builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1493803550.91 results: success (0) revision: 604acb6a6aece0d9f296dbb7ca091f45713c0c9d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:50.907180) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:50.907666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:50.907947) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:50.922445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:50.922709) ========= 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=df17445c3590ff7897617a0e00000225-1493803550.345958-710848337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-03 02:25:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2017-05-03 02:25:51 (37.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127716 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:51.063729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:51.064030) ========= 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=df17445c3590ff7897617a0e00000225-1493803550.345958-710848337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019508 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:51.115594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 02:25:51.115892) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 604acb6a6aece0d9f296dbb7ca091f45713c0c9d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 604acb6a6aece0d9f296dbb7ca091f45713c0c9d --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=df17445c3590ff7897617a0e00000225-1493803550.345958-710848337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-03 02:25:51,436 truncating revision to first 12 chars 2017-05-03 02:25:51,436 Setting DEBUG logging. 2017-05-03 02:25:51,436 attempt 1/10 2017-05-03 02:25:51,436 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/604acb6a6aec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 02:25:52,423 unpacking tar archive at: mozilla-central-604acb6a6aec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.251047 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 02:25:52.380701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:52.381014) ========= script_repo_revision: 604acb6a6aece0d9f296dbb7ca091f45713c0c9d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:52.384398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:52.384666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:52.395261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-03 02:25:52.395525) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1493803550.345958-710848337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:25:52 INFO - MultiFileLogger online at 20170503 02:25:52 in /builds/slave/test 02:25:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:25:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:25:52 INFO - {'append_to_log': False, 02:25:52 INFO - 'base_work_dir': '/builds/slave/test', 02:25:52 INFO - 'blob_upload_branch': 'Firefox', 02:25:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:25:52 INFO - 'branch': 'Firefox', 02:25:52 INFO - 'buildbot_json_path': 'buildprops.json', 02:25:52 INFO - 'config_files': ('talos/linux_config.py',), 02:25:52 INFO - 'default_actions': ('clobber', 02:25:52 INFO - 'read-buildbot-config', 02:25:52 INFO - 'download-and-extract', 02:25:52 INFO - 'populate-webroot', 02:25:52 INFO - 'create-virtualenv', 02:25:52 INFO - 'install', 02:25:52 INFO - 'run-tests'), 02:25:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:25:52 INFO - 'download_minidump_stackwalk': True, 02:25:52 INFO - 'download_symbols': 'ondemand', 02:25:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:25:52 INFO - 'tooltool.py': '/tools/tooltool.py', 02:25:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:25:52 INFO - '/tools/misc-python/virtualenv.py')}, 02:25:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:25:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:25:52 INFO - 'gecko_profile': False, 02:25:52 INFO - 'gecko_profile_interval': 0, 02:25:52 INFO - 'installer_path': 'installer.exe', 02:25:52 INFO - 'log_level': 'info', 02:25:52 INFO - 'log_name': 'talos', 02:25:52 INFO - 'log_to_console': True, 02:25:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:25:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:25:52 INFO - 'opt_config_files': (), 02:25:52 INFO - 'pip_index': False, 02:25:52 INFO - 'suite': 'dromaeojs', 02:25:52 INFO - 'system_bits': '32', 02:25:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:25:52 INFO - 'title': 'talos-linux64-ix-021', 02:25:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:25:52 INFO - 'use_talos_json': True, 02:25:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:25:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:25:52 INFO - 'work_dir': 'build'} 02:25:52 INFO - [mozharness: 2017-05-03 09:25:52.810127Z] Running clobber step. 02:25:52 INFO - Running pre-action listener: _resource_record_pre_action 02:25:52 INFO - Running main action method: clobber 02:25:52 INFO - rmtree: /builds/slave/test/build 02:25:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:25:54 INFO - Running post-action listener: _resource_record_post_action 02:25:54 INFO - [mozharness: 2017-05-03 09:25:54.368195Z] Finished clobber step (success) 02:25:54 INFO - [mozharness: 2017-05-03 09:25:54.368294Z] Running read-buildbot-config step. 02:25:54 INFO - Running pre-action listener: _resource_record_pre_action 02:25:54 INFO - Running main action method: read_buildbot_config 02:25:54 INFO - Using buildbot properties: 02:25:54 INFO - { 02:25:54 INFO - "project": "", 02:25:54 INFO - "product": "firefox", 02:25:54 INFO - "who": "cbook@mozilla.com", 02:25:54 INFO - "installer_path": "public/build/target.tar.bz2", 02:25:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:25:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:25:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 02:25:54 INFO - "stage_platform": "linux64-pgo", 02:25:54 INFO - "basedir": "/builds/slave/test", 02:25:54 INFO - "buildnumber": 162, 02:25:54 INFO - "platform": "ubuntu64_hw", 02:25:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:25:54 INFO - "slavebuilddir": "test", 02:25:54 INFO - "taskId": "CPqNlgi3TMOoKdNTHIrSeg", 02:25:54 INFO - "branch": "mozilla-central", 02:25:54 INFO - "script_repo_revision": "production", 02:25:54 INFO - "revision": "604acb6a6aece0d9f296dbb7ca091f45713c0c9d", 02:25:54 INFO - "slavename": "talos-linux64-ix-021", 02:25:54 INFO - "repo_path": "mozilla-central" 02:25:54 INFO - } 02:25:54 INFO - Finding installer, test and symbols from parent task. 02:25:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CPqNlgi3TMOoKdNTHIrSeg'}, attempt #1 02:25:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CPqNlgi3TMOoKdNTHIrSeg'}, attempt #1 02:25:55 INFO - Task dependencies: RLhhxqQ_SKC77_0XvfS-VA 02:25:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA'}, attempt #1 02:25:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.tar.bz2 02:25:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/test_packages.json 02:25:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.crashreporter-symbols.zip 02:25:55 INFO - Running post-action listener: _resource_record_post_action 02:25:55 INFO - [mozharness: 2017-05-03 09:25:55.845591Z] Finished read-buildbot-config step (success) 02:25:55 INFO - [mozharness: 2017-05-03 09:25:55.845811Z] Running download-and-extract step. 02:25:55 INFO - Running pre-action listener: _resource_record_pre_action 02:25:55 INFO - Running main action method: download_and_extract 02:25:55 INFO - mkdir: /builds/slave/test/build/tests 02:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:55 INFO - trying https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.test_packages.json 02:25:55 INFO - Downloading https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:25:56 INFO - Downloaded 986 bytes. 02:25:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:25:56 INFO - Using the following test package requirements: 02:25:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:25:56 INFO - u'common': [u'target.common.tests.zip'], 02:25:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:25:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:25:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:25:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:25:56 INFO - u'mozbase': [u'target.common.tests.zip'], 02:25:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:25:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:25:56 INFO - u'web-platform': [u'target.common.tests.zip', 02:25:56 INFO - u'target.web-platform.tests.zip'], 02:25:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:25:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:25:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.common.tests.zip 02:25:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:25:56 INFO - Fetch https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.common.tests.zip into memory 02:25:57 INFO - Content-Length response header: 60557740 02:25:57 INFO - Bytes received: 60557740 02:26:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:26:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.common.tests.zip 02:26:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:26:07 INFO - Fetch https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.common.tests.zip into memory 02:26:09 INFO - Content-Length response header: 60557740 02:26:09 INFO - Bytes received: 60557740 02:26:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.talos.tests.zip 02:26:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:26:19 INFO - Fetch https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.talos.tests.zip into memory 02:26:20 INFO - Content-Length response header: 14408811 02:26:20 INFO - Bytes received: 14408811 02:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:20 INFO - trying https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.tar.bz2 02:26:20 INFO - Downloading https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:26:21 INFO - Downloaded 64185308 bytes. 02:26:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.tar.bz2 02:26:21 INFO - mkdir: /builds/slave/test/properties 02:26:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:21 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:21 INFO - Contents: 02:26:21 INFO - build_url:https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.tar.bz2 02:26:21 INFO - Running post-action listener: _resource_record_post_action 02:26:21 INFO - Running post-action listener: set_extra_try_arguments 02:26:21 INFO - [mozharness: 2017-05-03 09:26:21.989799Z] Finished download-and-extract step (success) 02:26:21 INFO - [mozharness: 2017-05-03 09:26:21.989897Z] Running populate-webroot step. 02:26:21 INFO - Running pre-action listener: _resource_record_pre_action 02:26:21 INFO - Running main action method: populate_webroot 02:26:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:26:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:26:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:26:21 INFO - '--tppagecycles', 02:26:21 INFO - '7'], 02:26:21 INFO - 'tests': ['tsvgm']}}, 02:26:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:26:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:26:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:26:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:26:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:26:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:26:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:26:21 INFO - 'talos_options': ['--disable-e10s'], 02:26:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:26:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:26:21 INFO - 'talos_options': ['--disable-e10s'], 02:26:21 INFO - 'tests': ['damp', 'tps']}, 02:26:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:26:21 INFO - 'tests': ['damp', 'tps']}, 02:26:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:26:21 INFO - 'tests': ['dromaeo_dom']}, 02:26:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:26:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:26:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:26:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:26:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:26:21 INFO - 'tests': ['a11yr', 02:26:21 INFO - 'ts_paint', 02:26:21 INFO - 'tpaint', 02:26:21 INFO - 'sessionrestore', 02:26:21 INFO - 'sessionrestore_no_auto_restore', 02:26:21 INFO - 'tabpaint']}, 02:26:21 INFO - 'other-e10s': {'tests': ['a11yr', 02:26:21 INFO - 'ts_paint', 02:26:21 INFO - 'tpaint', 02:26:21 INFO - 'sessionrestore', 02:26:21 INFO - 'sessionrestore_no_auto_restore', 02:26:21 INFO - 'tabpaint']}, 02:26:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:26:21 INFO - 'ts_paint', 02:26:21 INFO - 'tpaint', 02:26:21 INFO - 'sessionrestore', 02:26:21 INFO - 'sessionrestore_no_auto_restore', 02:26:21 INFO - 'tabpaint']}, 02:26:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:26:21 INFO - 'ts_paint', 02:26:21 INFO - 'tpaint', 02:26:22 INFO - 'sessionrestore', 02:26:22 INFO - 'sessionrestore_no_auto_restore', 02:26:22 INFO - 'tabpaint']}, 02:26:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:26:22 INFO - 'tests': ['a11yr', 02:26:22 INFO - 'ts_paint', 02:26:22 INFO - 'tpaint', 02:26:22 INFO - 'sessionrestore', 02:26:22 INFO - 'sessionrestore_no_auto_restore', 02:26:22 INFO - 'tabpaint']}, 02:26:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:26:22 INFO - 'tests': ['a11yr', 02:26:22 INFO - 'ts_paint', 02:26:22 INFO - 'tpaint', 02:26:22 INFO - 'sessionrestore', 02:26:22 INFO - 'sessionrestore_no_auto_restore', 02:26:22 INFO - 'tabpaint']}, 02:26:22 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:26:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:26:22 INFO - 'bloom_basic_ref']}, 02:26:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:26:22 INFO - 'tests': ['tsvgx', 02:26:22 INFO - 'tsvgr_opacity', 02:26:22 INFO - 'tart', 02:26:22 INFO - 'tscrollx', 02:26:22 INFO - 'cart', 02:26:22 INFO - 'tsvg_static']}, 02:26:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:26:22 INFO - 'tsvgr_opacity', 02:26:22 INFO - 'tart', 02:26:22 INFO - 'tscrollx', 02:26:22 INFO - 'cart', 02:26:22 INFO - 'tsvg_static']}, 02:26:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:26:22 INFO - 'talos_options': ['--disable-e10s'], 02:26:22 INFO - 'tests': ['tp5o']}, 02:26:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:26:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:26:22 INFO - 'talos_options': ['--disable-e10s', 02:26:22 INFO - '--xperf_path', 02:26:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:22 INFO - 'tests': ['tp5n']}, 02:26:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:26:22 INFO - 'talos_options': ['--xperf_path', 02:26:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:22 INFO - 'tests': ['tp5n']}}, 02:26:22 INFO - 'talos.zip': {'path': '', 02:26:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:26:22 INFO - Running post-action listener: _resource_record_post_action 02:26:22 INFO - [mozharness: 2017-05-03 09:26:22.003706Z] Finished populate-webroot step (success) 02:26:22 INFO - [mozharness: 2017-05-03 09:26:22.003797Z] Running create-virtualenv step. 02:26:22 INFO - Running pre-action listener: _resource_record_pre_action 02:26:22 INFO - Running main action method: create_virtualenv 02:26:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:26:22 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 02:26:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:26:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:26:22 INFO - Using real prefix '/usr' 02:26:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:26:22 INFO - Installing distribute.............................................................................................................................................................................................done. 02:26:24 INFO - Installing pip.................done. 02:26:24 INFO - Return code: 0 02:26:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:26:24 INFO - Reading from file tmpfile_stdout 02:26:24 INFO - Output received: 02:26:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:26:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:24 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:24 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 02:26:24 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 02:26:24 INFO - Using env: {'DISPLAY': ':0', 02:26:24 INFO - 'HOME': '/home/cltbld', 02:26:24 INFO - 'LANG': 'en_US.UTF-8', 02:26:24 INFO - 'LANGUAGE': 'en_US:en', 02:26:24 INFO - 'LOGNAME': 'cltbld', 02:26:24 INFO - 'MAIL': '/var/mail/cltbld', 02:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:24 INFO - 'MOZ_NO_REMOTE': '1', 02:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:24 INFO - 'NO_EM_RESTART': '1', 02:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:24 INFO - 'PWD': '/builds/slave/test', 02:26:24 INFO - 'SHELL': '/bin/bash', 02:26:24 INFO - 'SHLVL': '1', 02:26:24 INFO - 'TERM': 'linux', 02:26:24 INFO - 'TMOUT': '86400', 02:26:24 INFO - 'USER': 'cltbld', 02:26:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:24 INFO - '_': '/tools/buildbot/bin/python'} 02:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:25 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 02:26:25 INFO - Cleaning up... 02:26:25 INFO - Return code: 0 02:26:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:25 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:25 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 02:26:25 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 02:26:25 INFO - Using env: {'DISPLAY': ':0', 02:26:25 INFO - 'HOME': '/home/cltbld', 02:26:25 INFO - 'LANG': 'en_US.UTF-8', 02:26:25 INFO - 'LANGUAGE': 'en_US:en', 02:26:25 INFO - 'LOGNAME': 'cltbld', 02:26:25 INFO - 'MAIL': '/var/mail/cltbld', 02:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:25 INFO - 'MOZ_NO_REMOTE': '1', 02:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:25 INFO - 'NO_EM_RESTART': '1', 02:26:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:25 INFO - 'PWD': '/builds/slave/test', 02:26:25 INFO - 'SHELL': '/bin/bash', 02:26:25 INFO - 'SHLVL': '1', 02:26:25 INFO - 'TERM': 'linux', 02:26:25 INFO - 'TMOUT': '86400', 02:26:25 INFO - 'USER': 'cltbld', 02:26:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:25 INFO - '_': '/tools/buildbot/bin/python'} 02:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:25 INFO - Downloading/unpacking psutil>=3.1.1 02:26:25 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 02:26:25 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 02:26:25 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 02:26:25 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 02:26:25 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 02:26:25 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 02:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:26 INFO - Installing collected packages: psutil 02:26:26 INFO - Running setup.py install for psutil 02:26:26 INFO - building 'psutil._psutil_linux' extension 02:26:26 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 02:26:26 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 02:26:26 INFO - building 'psutil._psutil_posix' extension 02:26:26 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 02:26:26 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 02:26:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:26 INFO - Successfully installed psutil 02:26:26 INFO - Cleaning up... 02:26:26 INFO - Return code: 0 02:26:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:26 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:26 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 02:26:26 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 02:26:26 INFO - Using env: {'DISPLAY': ':0', 02:26:26 INFO - 'HOME': '/home/cltbld', 02:26:26 INFO - 'LANG': 'en_US.UTF-8', 02:26:26 INFO - 'LANGUAGE': 'en_US:en', 02:26:26 INFO - 'LOGNAME': 'cltbld', 02:26:26 INFO - 'MAIL': '/var/mail/cltbld', 02:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:26 INFO - 'MOZ_NO_REMOTE': '1', 02:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:26 INFO - 'NO_EM_RESTART': '1', 02:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:26 INFO - 'PWD': '/builds/slave/test', 02:26:26 INFO - 'SHELL': '/bin/bash', 02:26:26 INFO - 'SHLVL': '1', 02:26:26 INFO - 'TERM': 'linux', 02:26:26 INFO - 'TMOUT': '86400', 02:26:26 INFO - 'USER': 'cltbld', 02:26:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:26 INFO - '_': '/tools/buildbot/bin/python'} 02:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:26:27 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 02:26:27 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 02:26:27 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 02:26:27 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 02:26:27 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 02:26:27 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 02:26:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:26:28 INFO - Installing collected packages: mozsystemmonitor 02:26:28 INFO - Running setup.py install for mozsystemmonitor 02:26:28 INFO - Successfully installed mozsystemmonitor 02:26:28 INFO - Cleaning up... 02:26:28 INFO - Return code: 0 02:26:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:28 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:28 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 02:26:28 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 02:26:28 INFO - Using env: {'DISPLAY': ':0', 02:26:28 INFO - 'HOME': '/home/cltbld', 02:26:28 INFO - 'LANG': 'en_US.UTF-8', 02:26:28 INFO - 'LANGUAGE': 'en_US:en', 02:26:28 INFO - 'LOGNAME': 'cltbld', 02:26:28 INFO - 'MAIL': '/var/mail/cltbld', 02:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:28 INFO - 'MOZ_NO_REMOTE': '1', 02:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:28 INFO - 'NO_EM_RESTART': '1', 02:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:28 INFO - 'PWD': '/builds/slave/test', 02:26:28 INFO - 'SHELL': '/bin/bash', 02:26:28 INFO - 'SHLVL': '1', 02:26:28 INFO - 'TERM': 'linux', 02:26:28 INFO - 'TMOUT': '86400', 02:26:28 INFO - 'USER': 'cltbld', 02:26:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:28 INFO - '_': '/tools/buildbot/bin/python'} 02:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:28 INFO - Downloading/unpacking jsonschema==2.5.1 02:26:28 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 02:26:28 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 02:26:28 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 02:26:28 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 02:26:28 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 02:26:28 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 02:26:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:26:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:26:29 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 02:26:29 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 02:26:29 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 02:26:29 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 02:26:29 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 02:26:29 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 02:26:29 INFO - Downloading functools32-3.2.3-2.tar.gz 02:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:26:29 INFO - warning: no files found matching '*.txt' 02:26:29 INFO - no previously-included directories found matching 'build' 02:26:29 INFO - no previously-included directories found matching 'dist' 02:26:29 INFO - no previously-included directories found matching '.git*' 02:26:29 INFO - Installing collected packages: jsonschema, functools32 02:26:29 INFO - Running setup.py install for functools32 02:26:30 INFO - warning: no files found matching '*.txt' 02:26:30 INFO - no previously-included directories found matching 'build' 02:26:30 INFO - no previously-included directories found matching 'dist' 02:26:30 INFO - no previously-included directories found matching '.git*' 02:26:30 INFO - Successfully installed jsonschema functools32 02:26:30 INFO - Cleaning up... 02:26:30 INFO - Return code: 0 02:26:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:30 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:30 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 02:26:30 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 02:26:30 INFO - Using env: {'DISPLAY': ':0', 02:26:30 INFO - 'HOME': '/home/cltbld', 02:26:30 INFO - 'LANG': 'en_US.UTF-8', 02:26:30 INFO - 'LANGUAGE': 'en_US:en', 02:26:30 INFO - 'LOGNAME': 'cltbld', 02:26:30 INFO - 'MAIL': '/var/mail/cltbld', 02:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:30 INFO - 'MOZ_NO_REMOTE': '1', 02:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:30 INFO - 'NO_EM_RESTART': '1', 02:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:30 INFO - 'PWD': '/builds/slave/test', 02:26:30 INFO - 'SHELL': '/bin/bash', 02:26:30 INFO - 'SHLVL': '1', 02:26:30 INFO - 'TERM': 'linux', 02:26:30 INFO - 'TMOUT': '86400', 02:26:30 INFO - 'USER': 'cltbld', 02:26:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:30 INFO - '_': '/tools/buildbot/bin/python'} 02:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:26:30 INFO - Cleaning up... 02:26:30 INFO - Return code: 0 02:26:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:30 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:30 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 02:26:30 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 02:26:30 INFO - Using env: {'DISPLAY': ':0', 02:26:30 INFO - 'HOME': '/home/cltbld', 02:26:30 INFO - 'LANG': 'en_US.UTF-8', 02:26:30 INFO - 'LANGUAGE': 'en_US:en', 02:26:30 INFO - 'LOGNAME': 'cltbld', 02:26:30 INFO - 'MAIL': '/var/mail/cltbld', 02:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:30 INFO - 'MOZ_NO_REMOTE': '1', 02:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:30 INFO - 'NO_EM_RESTART': '1', 02:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:30 INFO - 'PWD': '/builds/slave/test', 02:26:30 INFO - 'SHELL': '/bin/bash', 02:26:30 INFO - 'SHLVL': '1', 02:26:30 INFO - 'TERM': 'linux', 02:26:30 INFO - 'TMOUT': '86400', 02:26:30 INFO - 'USER': 'cltbld', 02:26:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:30 INFO - '_': '/tools/buildbot/bin/python'} 02:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:30 INFO - Downloading/unpacking blobuploader==1.2.4 02:26:30 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 02:26:30 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 02:26:30 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 02:26:30 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 02:26:30 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 02:26:30 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 02:26:31 INFO - Downloading blobuploader-1.2.4.tar.gz 02:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:26:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:26:31 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 02:26:31 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 02:26:31 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 02:26:31 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 02:26:31 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 02:26:31 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 02:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:26:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:26:31 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 02:26:31 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 02:26:31 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 02:26:31 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 02:26:31 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 02:26:31 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 02:26:33 INFO - Downloading docopt-0.6.1.tar.gz 02:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:26:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:26:33 INFO - Running setup.py install for blobuploader 02:26:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:26:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:26:33 INFO - Running setup.py install for requests 02:26:33 INFO - Running setup.py install for docopt 02:26:33 INFO - Successfully installed blobuploader requests docopt 02:26:33 INFO - Cleaning up... 02:26:33 INFO - Return code: 0 02:26:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:33 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:33 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 02:26:33 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 02:26:33 INFO - Using env: {'DISPLAY': ':0', 02:26:33 INFO - 'HOME': '/home/cltbld', 02:26:33 INFO - 'LANG': 'en_US.UTF-8', 02:26:33 INFO - 'LANGUAGE': 'en_US:en', 02:26:33 INFO - 'LOGNAME': 'cltbld', 02:26:33 INFO - 'MAIL': '/var/mail/cltbld', 02:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:33 INFO - 'MOZ_NO_REMOTE': '1', 02:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:33 INFO - 'NO_EM_RESTART': '1', 02:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:33 INFO - 'PWD': '/builds/slave/test', 02:26:33 INFO - 'SHELL': '/bin/bash', 02:26:33 INFO - 'SHLVL': '1', 02:26:33 INFO - 'TERM': 'linux', 02:26:33 INFO - 'TMOUT': '86400', 02:26:33 INFO - 'USER': 'cltbld', 02:26:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:33 INFO - '_': '/tools/buildbot/bin/python'} 02:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:33 INFO - Running setup.py (path:/tmp/pip-MmuaYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:34 INFO - Running setup.py (path:/tmp/pip-xxI7zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:34 INFO - Running setup.py (path:/tmp/pip-wRwNm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:34 INFO - Running setup.py (path:/tmp/pip-ver4vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:34 INFO - Running setup.py (path:/tmp/pip-FbBVcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:34 INFO - Running setup.py (path:/tmp/pip-6Tcpct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:34 INFO - Running setup.py (path:/tmp/pip-rIuCWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:34 INFO - Running setup.py (path:/tmp/pip-2ijJWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:34 INFO - Running setup.py (path:/tmp/pip-p1H86x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:34 INFO - Running setup.py (path:/tmp/pip-3z69Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:34 INFO - Running setup.py (path:/tmp/pip-VbXJtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:34 INFO - Running setup.py (path:/tmp/pip-me2n83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:34 INFO - Running setup.py (path:/tmp/pip-5abz6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:34 INFO - Running setup.py (path:/tmp/pip-VsC0k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:35 INFO - Running setup.py (path:/tmp/pip-lLuHgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:35 INFO - Running setup.py (path:/tmp/pip-ufCt_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:35 INFO - Running setup.py (path:/tmp/pip-luOV47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:26:35 INFO - Running setup.py install for manifestparser 02:26:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Running setup.py install for mozcrash 02:26:35 INFO - Running setup.py install for mozdebug 02:26:35 INFO - Running setup.py install for mozdevice 02:26:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Running setup.py install for mozfile 02:26:35 INFO - Running setup.py install for mozhttpd 02:26:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Running setup.py install for mozinfo 02:26:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Running setup.py install for mozInstall 02:26:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Running setup.py install for mozleak 02:26:36 INFO - Running setup.py install for mozlog 02:26:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Running setup.py install for moznetwork 02:26:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Running setup.py install for mozprocess 02:26:36 INFO - Running setup.py install for mozprofile 02:26:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Running setup.py install for mozrunner 02:26:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Running setup.py install for mozscreenshot 02:26:36 INFO - Running setup.py install for moztest 02:26:36 INFO - Running setup.py install for mozversion 02:26:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:26:36 INFO - Cleaning up... 02:26:36 INFO - Return code: 0 02:26:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:37 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:37 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 02:26:37 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 02:26:37 INFO - Using env: {'DISPLAY': ':0', 02:26:37 INFO - 'HOME': '/home/cltbld', 02:26:37 INFO - 'LANG': 'en_US.UTF-8', 02:26:37 INFO - 'LANGUAGE': 'en_US:en', 02:26:37 INFO - 'LOGNAME': 'cltbld', 02:26:37 INFO - 'MAIL': '/var/mail/cltbld', 02:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:37 INFO - 'MOZ_NO_REMOTE': '1', 02:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:37 INFO - 'NO_EM_RESTART': '1', 02:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:37 INFO - 'PWD': '/builds/slave/test', 02:26:37 INFO - 'SHELL': '/bin/bash', 02:26:37 INFO - 'SHLVL': '1', 02:26:37 INFO - 'TERM': 'linux', 02:26:37 INFO - 'TMOUT': '86400', 02:26:37 INFO - 'USER': 'cltbld', 02:26:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:37 INFO - '_': '/tools/buildbot/bin/python'} 02:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:37 INFO - Running setup.py (path:/tmp/pip-cpvb3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:37 INFO - Running setup.py (path:/tmp/pip-48oBpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:37 INFO - Running setup.py (path:/tmp/pip-uySxXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:37 INFO - Running setup.py (path:/tmp/pip-Sl3FaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:37 INFO - Running setup.py (path:/tmp/pip-RA0Y7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:37 INFO - Running setup.py (path:/tmp/pip-BIYeCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:37 INFO - Running setup.py (path:/tmp/pip-ZDOxZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:37 INFO - Running setup.py (path:/tmp/pip-Afw9vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:37 INFO - Running setup.py (path:/tmp/pip-_MAOqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:37 INFO - Running setup.py (path:/tmp/pip-bW1I4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:37 INFO - Running setup.py (path:/tmp/pip-beupqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:38 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:38 INFO - Running setup.py (path:/tmp/pip-A9Jd8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:38 INFO - Running setup.py (path:/tmp/pip-VEboZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:38 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:38 INFO - Running setup.py (path:/tmp/pip-iOnnuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:38 INFO - Running setup.py (path:/tmp/pip-mEGyHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:38 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:38 INFO - Running setup.py (path:/tmp/pip-y71O18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:38 INFO - Running setup.py (path:/tmp/pip-7esBXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:38 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)) 02:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:26:38 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)) 02:26:38 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:38 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:38 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 02:26:38 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 02:26:38 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 02:26:38 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 02:26:38 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 02:26:38 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 02:26:39 INFO - Downloading blessings-1.6.tar.gz 02:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:39 INFO - Installing collected packages: blessings 02:26:39 INFO - Running setup.py install for blessings 02:26:39 INFO - Successfully installed blessings 02:26:39 INFO - Cleaning up... 02:26:39 INFO - Return code: 0 02:26:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:39 INFO - Reading from file tmpfile_stdout 02:26:39 INFO - Current package versions: 02:26:39 INFO - argparse == 1.2.1 02:26:39 INFO - blessings == 1.6 02:26:39 INFO - blobuploader == 1.2.4 02:26:39 INFO - docopt == 0.6.1 02:26:39 INFO - functools32 == 3.2.3-2 02:26:39 INFO - jsonschema == 2.5.1 02:26:39 INFO - manifestparser == 1.1 02:26:39 INFO - mozInstall == 1.12 02:26:39 INFO - mozcrash == 1.0 02:26:39 INFO - mozdebug == 0.1 02:26:39 INFO - mozdevice == 0.50 02:26:39 INFO - mozfile == 1.2 02:26:39 INFO - mozhttpd == 0.7 02:26:39 INFO - mozinfo == 0.9 02:26:39 INFO - mozleak == 0.1 02:26:39 INFO - mozlog == 3.4 02:26:39 INFO - moznetwork == 0.27 02:26:39 INFO - mozprocess == 0.25 02:26:39 INFO - mozprofile == 0.28 02:26:39 INFO - mozrunner == 6.13 02:26:39 INFO - mozscreenshot == 0.1 02:26:39 INFO - mozsystemmonitor == 0.3 02:26:39 INFO - moztest == 0.8 02:26:39 INFO - mozversion == 1.4 02:26:39 INFO - psutil == 3.1.1 02:26:39 INFO - requests == 1.2.3 02:26:39 INFO - wsgiref == 0.1.2 02:26:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:39 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:39 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 02:26:39 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 02:26:39 INFO - Using env: {'DISPLAY': ':0', 02:26:39 INFO - 'HOME': '/home/cltbld', 02:26:39 INFO - 'LANG': 'en_US.UTF-8', 02:26:39 INFO - 'LANGUAGE': 'en_US:en', 02:26:39 INFO - 'LOGNAME': 'cltbld', 02:26:39 INFO - 'MAIL': '/var/mail/cltbld', 02:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:40 INFO - 'MOZ_NO_REMOTE': '1', 02:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:40 INFO - 'NO_EM_RESTART': '1', 02:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:40 INFO - 'PWD': '/builds/slave/test', 02:26:40 INFO - 'SHELL': '/bin/bash', 02:26:40 INFO - 'SHLVL': '1', 02:26:40 INFO - 'TERM': 'linux', 02:26:40 INFO - 'TMOUT': '86400', 02:26:40 INFO - 'USER': 'cltbld', 02:26:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:40 INFO - '_': '/tools/buildbot/bin/python'} 02:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:40 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)) 02:26:40 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)) 02:26:40 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)) 02:26:40 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)) 02:26:40 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)) 02:26:40 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)) 02:26:40 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)) 02:26:40 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)) 02:26:40 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)) 02:26:40 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)) 02:26:40 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)) 02:26:40 INFO - Cleaning up... 02:26:40 INFO - Return code: 0 02:26:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:40 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 0xc5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, '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': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', '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 02:26:40 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 02:26:40 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 02:26:40 INFO - Using env: {'DISPLAY': ':0', 02:26:40 INFO - 'HOME': '/home/cltbld', 02:26:40 INFO - 'LANG': 'en_US.UTF-8', 02:26:40 INFO - 'LANGUAGE': 'en_US:en', 02:26:40 INFO - 'LOGNAME': 'cltbld', 02:26:40 INFO - 'MAIL': '/var/mail/cltbld', 02:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:40 INFO - 'MOZ_NO_REMOTE': '1', 02:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:40 INFO - 'NO_EM_RESTART': '1', 02:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:40 INFO - 'PWD': '/builds/slave/test', 02:26:40 INFO - 'SHELL': '/bin/bash', 02:26:40 INFO - 'SHLVL': '1', 02:26:40 INFO - 'TERM': 'linux', 02:26:40 INFO - 'TMOUT': '86400', 02:26:40 INFO - 'USER': 'cltbld', 02:26:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:40 INFO - '_': '/tools/buildbot/bin/python'} 02:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:40 INFO - Cleaning up... 02:26:40 INFO - Return code: 0 02:26:40 INFO - Running post-action listener: _resource_record_post_action 02:26:40 INFO - Running post-action listener: _start_resource_monitoring 02:26:40 INFO - Starting resource monitoring. 02:26:40 INFO - [mozharness: 2017-05-03 09:26:40.496270Z] Finished create-virtualenv step (success) 02:26:40 INFO - [mozharness: 2017-05-03 09:26:40.496791Z] Running install step. 02:26:40 INFO - Running pre-action listener: _resource_record_pre_action 02:26:40 INFO - Running main action method: install 02:26:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:40 INFO - Reading from file tmpfile_stdout 02:26:40 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:40 INFO - Reading from file tmpfile_stdout 02:26:40 INFO - Output received: 02:26:40 INFO - Usage: mozinstall [options] installer 02:26:40 INFO - Options: 02:26:40 INFO - -h, --help show this help message and exit 02:26:40 INFO - -d DEST, --destination=DEST 02:26:40 INFO - Directory to install application into. [default: 02:26:40 INFO - "/builds/slave/test"] 02:26:40 INFO - --app=APP Application being installed. [default: firefox] 02:26:40 INFO - mkdir: /builds/slave/test/build/application 02:26:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:26:57 INFO - Reading from file tmpfile_stdout 02:26:57 INFO - Output received: 02:26:57 INFO - /builds/slave/test/build/application/firefox/firefox 02:26:57 INFO - Running post-action listener: _resource_record_post_action 02:26:57 INFO - [mozharness: 2017-05-03 09:26:57.083679Z] Finished install step (success) 02:26:57 INFO - [mozharness: 2017-05-03 09:26:57.083956Z] Running run-tests step. 02:26:57 INFO - Running pre-action listener: _resource_record_pre_action 02:26:57 INFO - Running main action method: run_tests 02:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:26:57 INFO - Python 2.7.3 02:26:57 INFO - Return code: 0 02:26:57 INFO - grabbing minidump binary from tooltool 02:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:57 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 0xef8400>, '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 0xef93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef9840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:26:57 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 02:26:57 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 02:26:57 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 02:26:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:26:57 INFO - Return code: 0 02:26:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:26:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:26:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:26:57 INFO - ENV: RUST_BACKTRACE is now 1 02:26:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:26:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 02:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 02:26:57 INFO - Using env: {'DISPLAY': ':0', 02:26:57 INFO - 'HOME': '/home/cltbld', 02:26:57 INFO - 'LANG': 'en_US.UTF-8', 02:26:57 INFO - 'LANGUAGE': 'en_US:en', 02:26:57 INFO - 'LOGNAME': 'cltbld', 02:26:57 INFO - 'MAIL': '/var/mail/cltbld', 02:26:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:26:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:57 INFO - 'MOZ_NO_REMOTE': '1', 02:26:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:57 INFO - 'NO_EM_RESTART': '1', 02:26:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:57 INFO - 'PWD': '/builds/slave/test', 02:26:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:26:57 INFO - 'RUST_BACKTRACE': '1', 02:26:57 INFO - 'SHELL': '/bin/bash', 02:26:57 INFO - 'SHLVL': '1', 02:26:57 INFO - 'TERM': 'linux', 02:26:57 INFO - 'TMOUT': '86400', 02:26:57 INFO - 'USER': 'cltbld', 02:26:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1493803550.345958-710848337', 02:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:57 INFO - '_': '/tools/buildbot/bin/python'} 02:26:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 02:26:57 INFO - mozversion application_buildid: 20170503082833 02:26:57 INFO - mozversion application_changeset: 604acb6a6aece0d9f296dbb7ca091f45713c0c9d 02:26:57 INFO - mozversion application_display_name: Nightly 02:26:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:26:57 INFO - mozversion application_name: Firefox 02:26:57 INFO - mozversion application_remotingname: firefox 02:26:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:26:57 INFO - mozversion application_vendor: Mozilla 02:26:57 INFO - mozversion application_version: 55.0a1 02:26:57 INFO - mozversion platform_buildid: 20170503082833 02:26:57 INFO - mozversion platform_changeset: 604acb6a6aece0d9f296dbb7ca091f45713c0c9d 02:26:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:26:57 INFO - mozversion platform_version: 55.0a1 02:26:57 INFO - using testdate: 1493803617 02:26:57 INFO - actual date: 1493803617 02:26:57 INFO - starting webserver on 'localhost:55446' 02:26:57 INFO - SUITE-START | Running 2 tests 02:26:57 INFO - TEST-START | dromaeo_css 02:26:57 INFO - operating with platform_type : linux_ 02:26:57 INFO - Initialising browser for dromaeo_css test... 02:26:57 INFO - TEST-INFO | started process 17014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8lAFxL/profile http://localhost:55446/getInfo.html) 02:27:01 INFO - PID 17014 | __metrics Screen width/height:1600/1200 02:27:01 INFO - PID 17014 | colorDepth:24 02:27:01 INFO - PID 17014 | Browser inner width/height: 1024/695 02:27:01 INFO - PID 17014 | __metrics 02:27:02 INFO - PID 17014 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:27:02 INFO - PID 17014 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:27:03 INFO - TEST-INFO | 17014: exit 0 02:27:03 INFO - Browser initialized. 02:27:03 INFO - Running cycle 1/1 for dromaeo_css test... 02:27:03 INFO - TEST-INFO | started process 17109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8lAFxL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:15 INFO - PID 17109 | RSS: Main: 151224320 02:27:15 INFO - PID 17109 | 02:30:17 INFO - PID 17109 | Cycle 1(1): loaded http://localhost:55446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55446/tests/dromaeo/cssquery-ext.html) 02:30:19 INFO - PID 17109 | RSS: Main: 301314048 02:30:19 INFO - PID 17109 | 02:33:21 INFO - PID 17109 | Cycle 1(1): loaded http://localhost:55446/tests/dromaeo/cssquery-ext.html (next: http://localhost:55446/tests/dromaeo/cssquery-jquery.html) 02:33:21 INFO - PID 17109 | RSS: Main: 228818944 02:33:21 INFO - PID 17109 | 02:36:23 INFO - PID 17109 | Cycle 1(1): loaded http://localhost:55446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55446/tests/dromaeo/cssquery-mootools.html) 02:36:24 INFO - PID 17109 | RSS: Main: 176623616 02:36:24 INFO - PID 17109 | 02:39:25 INFO - PID 17109 | Cycle 1(1): loaded http://localhost:55446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55446/tests/dromaeo/cssquery-prototype.html) 02:39:26 INFO - PID 17109 | RSS: Main: 174010368 02:39:26 INFO - PID 17109 | 02:42:29 INFO - PID 17109 | Cycle 1(1): loaded http://localhost:55446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55446/tests/dromaeo/cssquery-yui.html) 02:42:29 INFO - PID 17109 | RSS: Main: 175464448 02:42:29 INFO - PID 17109 | 02:45:31 INFO - PID 17109 | Cycle 1(1): loaded http://localhost:55446/tests/dromaeo/cssquery-yui.html (next: http://localhost:55446/tests/dromaeo/cssquery-dojo.html) 02:45:31 INFO - PID 17109 | RSS: Main: 273412096 02:45:31 INFO - PID 17109 | 02:45:31 INFO - PID 17109 | __start_tp_report 02:45:31 INFO - PID 17109 | _x_x_mozilla_page_load 02:45:31 INFO - PID 17109 | _x_x_mozilla_page_load_details 02:45:31 INFO - PID 17109 | |i|pagename|runs| 02:45:31 INFO - PID 17109 | |0;dojo.html;3324.7506437017228;3325.085601459599;3343.364760695468;3356.3958487472246;3378.0879162626093;5700.059490184115;5795.101759227321;5820.563457740675;5843.211166492522;5858.384869588695;5803.332616749075;5834.183214349994;5863.149843272734;5870.559708021894;5875;5118.053160165363;5141.4087379951225;5163.380394352665;5174.844754657366;5192.584593232532;5159.277701121846;5204.531592156705;5238.47615238475;5242.292290540785;5302.946970530284;5248.763805628756;5268.946210757845;5280.603954703393;5281.735913204344;5288.101022826109;840.1771437660632;5115.181570948667;5177.611679124081;5229.267902493654;5250.789968401259;5160.122779127557;5165;5168.173092305213;5170.121079416508;5171.974140129313;5698.943010569924;5791.940953520854;5823.068309070529;5831.9416805831825;5855.736491857877;6065.3535148213;6153.969230153865;6208.472279856218;6271.498280137578;6321.1150438938585;6409.583377080475;6425.1326070980285;6428.292887782341;6434.260060093103;6435.710393032325;5891.73487193073;5910.0248459004215;5912.881742365129;5917.497012753878;5930.169776231331;6285.654289014056;6383.39357761012;6432.4532414744335;6474.1907261592305;6532.281449040602;6201.224846894138;6223.875522489525;6224.315325314212;6233.252009758858;6234.251889773165;6275.529335299871;6295.559310848288;6318.052292156213;6346.9682651586445;6348.4286414222015;6095.468565591199;6171.753129874754;6182.227221597301;6189.938100618936;6326.177596912372;6223.626582405071;6278.277998030285;6332.525060620472;6333.904991425133;6339.144215530937;4820.305213232557;4822.083804077214;4823.686460380064;4835.1296766581645;4854.077725232195;4212.705110642226;4272.46594175728;4273.55127711592;4293.785310734451;4319.935200971988;5775.104858746901;5878.11828225761;5909.172715819789;5926.585139040312;5937.614055086406;6324.716562316446;6355.110284560165;6390.552661313756;6391.105245265667;6397.52018598607;5871.794487192928;5876.853078673067;5879.353271140171;5900.291964964232;5908.409159084057;5321.175217841241;5470.152126420332;5474.069408200616;5545.556355491551;5549.556035517229;6674.699638516278;6687.264400915993;6687.966560167168;6702.899456508058;6706.631135287606;6368.617882927039;6382.68086595659;6398.392152745481;6410.358964103552;6413.7113829876835;6375.840603984938;6446.8388290293115;6510.18622672166;6525.836854078496;6659.500537459613;6189.195404597373;6256.655883926428;6262.2172228471445;6280.717367718555;6283.057541368831;6384.297727249906;6390.840228994312;6393.168888044711;6400.199975003125;6400.455961243347;6045.57680962346;6091.908621370594;6123.479504242189;6142.754289828356;6183.5671502994355;6114.174586430775;6134.191681014119;6171.6297022178815;6174.135621012972;6190.2571691397325;6162.383761623802;6186.505079593711;6196.1015652731;6200.782972595937;6204.069389591597;6105.633661980295;6123.571350005635;6131.9272270139245;6139.768135342541;6221.595596286227;6050.45545900871;6058.57589968698;6070.453659170696;6078.3921607838865;6099.542534309856 02:45:31 INFO - PID 17109 | |1;ext.html;753.3483536740717;803.1727320859515;821.4660470694047;1143.7769634921183;1155.953761849526;30506.84746576267;38095.61904380955;39004.80497597508;39153.60846391535;39196;40830.7958460208;41110.58889411105;41176;41186.7940660297;41243.38134927971;5684.147377893308;5806.535477161838;7158.355747982707;7200.207977122525;7366.079240094961;7248.420126389876;7363.5581865088;7365;7372.668229929639;7378.040854688883;7352.63236838156;7398.630068496581;7431.628418579076;7436.1820199777985;7440.739574114907;7272.63636818157;7304.196538380774;7321;7362.263773622649;7403.2966868147705;7155.463340249502;7188.964055179743;7205.603691796949;7207.603581802999;7209.06282183318;37198.44202336967;37338.62661373379;37450;37466.62533374659;37512;3453.4647129694936;3483.303339332144;3484.0244731474972;3487.1630808606005;3487.47687846825;29107.708922910922;29113.417731645248;29280.121596352143;29442.70557294421;29446.558301625493;3829.1193025604266;3833.3291673956946;3840.635139661728;3851.5763266040713;3867.9226415471812;191706;191912;193122;193316;194110;48821;48964.265536016275;49153.508464915605;49291.26063109056;49335;51098.48901510937;51304.48695513072;51459.19892803734;51563.74218128961;51585;15207.771883421758;15259.542213733606;15328.386864525293;15329.6167595811;15336.539903802905;10153.340032897839;10330.173586113093;11995.520179192908;12113.454894529767;12373.814392784116;14158.85841141596;14209.289535523183;14219.289035548389;14251.928740356232;14335.426582936774;5405.4324295949145;5584;5648.661080335193;5677.318721753333;5700.686462244534;1057.3285963413134;1094.934303941766;1104.7735214281054;1107.4020029184312;1119.5409881948362;24608.753912461005;24631.3842153944;24784.876075619868;24842.875785620956;24871.253862384157;1200.6158029430499;1201.333260040686;1217.1419149499582;1233.3709807997986;1240.2000709542294;12975.675608109872;13073.617702984056;13223.867761322455;13296.335183240799;13359.465621375037;218938;219022;220499;220727;221143;52077.656505457344;52098;52153.73923130436;52552.47447525552;52556;1497.5282785922618;1509.7131545006414;1544.5520798968173;1545.0729562262777;1553.720330340527;22943.88528057349;23687.1709490167;24220.515589687755;24225.273241802774;24235.516429460607;39396.40905386479;39562.80218598888;39603.405948910215;39620.405693914036;39687;199842;199879;200541;201366;201783;30230.395392092476;30319.11968363002;34804.82597586996;34914.47628285527;34935.65064349324;40907.795461022506;40983.672122623866;42357.788211058745;43006.569934300256;43060.569394305654;29302.41395172042;30551.847240763655;31187.220319491287;31266.687333126378;32017.839910800296;31132.53301200529;31501;31524.36951261008;31626;31656.683433166294;36880.631193688794;36910.8154459226;36967.44548831823;37004.44493332656;37044.25911481701;28794.28014299659;29955.251118722208;30189.245268868453;30332.545011824397;30770;24910;25299.620505692797;25425.87287063553;25649.487010260065;25867.482650347265 02:45:31 INFO - PID 17109 | |2;jquery.html;421.51104718526517;442.8804222859828;451.1743509377839;455.9316102584612;460.84100985160126;18458.815411845877;19627.313044043443;20016.799832001674;20169.798302016974;20249;20524.692129618066;20952.476188095305;22359.664605030895;22464.32607021792;22528.986195621197;5456.154296084113;5647.265855438808;5651.180578816069;5653.575981801361;5657.405972372903;5453.918191227135;5514.696691681956;5570.275864137677;5575.832725018256;5586.748596313176;5517.282753242073;5533.810230800377;5542.944570554303;5543.334799824027;5543.750531226085;5469.863253418656;5520.503154716095;5537.833864984057;5552.194931734876;5561.360443548962;5057.873553161164;5080.669756465818;5091.898162036776;5098.439171691111;5099.33708617881;24528.87735561311;24736.876315618487;24768;24814.50370992588;24907.377315567075;2142.5500644864596;2176.0207906442165;2176.7279090113734;2177.4774054226873;2179.6403593407226;16927.66144677112;17592.384266550736;17644.294228230854;17705.468835934815;17751.201195946214;2151.956960860774;2165.07984106754;2175.6083904897114;2196.417949243452;2239.7760223977634;96713;97445;98134;98524;99341;12066.75866482683;12353.62939111828;12480.875191247971;12510.874891251153;12789.552365667158;17483.56291092733;17520.737188942177;17531;17538.824611753975;17600.64798704019;8225.341972642174;8394.874076888851;8527.74416767498;8599.39804213699;8637.654493820302;7589.1272503662785;7612.086549614081;7850.646720897574;7892.526448412998;7897.763067107996;7604.619769011527;7807.86785916039;7845.960770196112;7859.84280314402;7902.920970790334;2151.548174883292;2214.4685275533757;2225.888705564715;2255.436140964759;2256.943576410603;1067.1196263082988;1091.6070214722693;1100.4882729530807;1105.0605389663456;1106.6403418888892;20615.175392984114;21025.474363141046;21042.894785525976;21082.262120825697;21113.366599002056;1094.480121942071;1097.7475180708482;1106.5186643809968;1113.6547670222258;1119.574561666578;10750.002497677235;11381.260218085798;11503.194776365573;11536.365499897585;11562.248453850472;439325;440252;446874;452358;452910;96584;97839.51080244695;98318;98724.50637746765;100611;1160.733031402782;1216.0697066743949;1223.6451429085644;1228.993855030719;1250.5748045664336;17480.052328310296;17607.29570817153;18039.5490112743;18096.547586310448;18235.808733471324;46498.30252546282;46606;47134;47247;48096;57228.68682021713;59146.70426648011;59239.111413329694;59358.70320648542;59865.7006714981;9140.725778226664;9402.576884040098;9451.621935122517;9594.856077158709;10124;15144.924275378553;15177.468788592347;15587.532374028797;15608.687826243638;16491.09298988567;12993.805092923803;13074.607761767162;13277.66805829862;13582.25297608641;13662;12466.5013399463;12754.107212495037;12825;12959.35203239853;13447.125936814076;12525.185862918881;12841.036922230684;12993.350332483527;13338.199708017162;13535.120217185851;9301.069893010645;9447.480388578695;9505.42967421957;9658.21323055237;9666.95166524163;12643.304618246084;13117.34413279313;13134.671633208864;13145.145565538209;13233 02:45:31 INFO - PID 17109 | |3;mootools.html;1212.727136394311;1353.546561901763;1378.6829029323255;1408.901376903617;1411.6541447345403;9341.486218258002;10710.78578428431;11323.32060076396;11375.658730238085;11377.829332559997;11019.559217631286;11127.276727012739;11129.443527823616;11130.833037504444;11151.442427878614;2033.6746120620703;2355.2698663414353;2389.032441861049;2390.772876576731;2394.8443351182204;2085.228465467779;2297.2878407693584;2380.2621187431864;2382.725986511556;2388.3312672451652;2354.7174339079247;2366.7751563601514;2374.263978166774;2375.239923224569;2376.0377047295874;2311.8612883226974;2319.9072037118494;2320.153144102407;2322.001539338084;2323.6863023491865;2253.740819805727;2282.9543409131725;2287.0508738873345;2287.2680742162515;2294.5410917816503;11057.557697692082;11103.222774405795;11104.056155226815;11191.888081119247;11194.608188713437;6363.172787537636;6570.211574611029;6592.835179120512;6594.93405065948;6598.505112116611;3839.6736277416453;4020.43713880057;4188.4555007848785;4212.262854000538;4256.063665993476;1381.5095641047485;1386.8058471813954;1393.3520912775507;1430.8569143085713;1466.6773309871917;16812.32750689971;16813;16835.242414091394;16888.746668799977;16888.83111168897;5386.245925570423;5580.832575022756;5597.132444471114;5625.606207565513;5746.626469279484;13904.51334203298;13983.720325593431;13992.440302387995;13999;14006.71986560263;6602.372774586406;6625.105610742488;6625.668716564152;6630.071789949411;6636.336366363325;5923.703814809329;6006.909896351558;6045.818625441244;6112.572119951561;6118.296395914527;4307.18163548931;4474.821007159742;4479.440069991251;4503.909921801545;4577.633789296849;1388.7430825297151;1419.3471003338373;1428.6714055767231;1435.8994870358974;1454.338276084379;885.2077390735385;902.8284625921054;912.0879120879121;914.9771255718528;928.2388441478058;6762.323767623297;7092.829683102231;7317.670704818296;7379.520331178456;7526.623668816537;940.2431043010306;967.8209531236744;1002.9548670309854;1020.9489525523843;1030.6701855406197;4515.367848501212;4576.771161441981;4682.789274482657;4706.482286948433;4730.101280756714;14554.781678274834;14801.481948131765;15055.322510487054;15246.3901443941;15292.158931258888;14669.33987970544;14813.185274809988;14825.110493370217;14947.327370268364;14963.70072598542;8951.999999999869;8971.461712297283;9104.499252541042;9143;9171.63313467454;6789.490788190807;6820.624865632438;6844.8973265402055;6958.512904096665;7058.858822823412;13355.3990070449;13426.798598021232;13461.663458413617;13471.326433678472;13541.72916541644;11866.881331186578;13655.453781848615;13750.587482375544;13766.793498097337;13858;9545.952270238604;10509.264351495322;10780.838287425539;10813.513391897226;10815.67552973412;10610.628627997983;10753.516091775733;10800.891991079989;10837.783244335227;10862;9191.402558833654;9193.816123677356;9269.860952085859;9391.812163756824;9410.717678469657;8699.652013919373;8882;8935.195832375117;8953.731388058368;9061.637534498546;8254.669813207645;8316.708915187939;8418.747437576883;8420;8439.156084391512;5950.672713000827;6059.182010428536;6070;6095.878082438415;6112;6218.160548326099;6353.110564520878;6409.327020662763;6466.030095485715;6525.412712855866 02:45:31 INFO - PID 17109 | |4;prototype.html;421.13877121286976;425.77859513053215;426.15621070280827;436.3149854728078;437.6323887934135;5704.058830292996;5868.73590688419;5902.321233058199;5908.172855800191;5928.584999050068;5725.770969161239;5734.913976290349;5757.942420575793;5760.798372056979;5806.506446952004;4262.403263543107;4345.283028300327;4399.362092496586;4403.273459879132;4590.540945905408;4388.956110438902;4398.8900277493;4400.317950717628;4416.73499590024;4422.447194100738;4386.7367957922625;4389.275769498029;4394.033312671208;4397.098594788061;4400.295952647577;4328.523862375152;4349;4368.213721530124;4394.978025109886;4399.296112621981;3798.392257238856;3809.12390150267;3809.142942837839;3817.4464702617965;3822.0827001519715;5593.664380137205;5656.038473459522;5669.688167150805;5683.5169010634145;5689.516391106761;5067.77195026221;5098.97450512745;5124.2321399117245;5127.717975511346;5150.356205474316;6134.4172303631085;6141.815745527641;6150.477209437158;6159.168512250833;6167.259928808527;4286.057067445188;4291.077418355068;4294.398784170218;4295.5060168080445;4299.74201547905;6172.537059720539;6270.495081180484;6309.526785491106;6474.967625161891;6499.610023398611;4262.531121576686;4318.157959197926;4327.632151267115;4339.587739164837;4341.978290108593;4393.824247030083;4401.471823381151;4403.053343531156;4403.911921761547;4404.713693609905;4799.280107983761;4858.708477491362;5099.184130539096;5099.847004589868;5105.8723531912;6090;6160.784372547029;6162.058951430286;6170.352113028068;6191.288001879841;1503.075608500786;1510.6752048309665;1511.3199060422635;1515.636247300662;1519.6049027252993;1016.5019140621042;1173.1318824070297;1207.2575366149754;1214.5324050240722;1229.4283158331418;5880.176775251468;5890.8821823563285;5908.881822363529;5909.556783241274;5936.347001829795;6177.166082578884;6317.873642527124;6357.96821015892;6363.872722545523;6372.426481616677;5921.940780592225;5943.81123775238;5948.3047331510315;5972.432618901197;5972.432618901197;3312.685294896981;3343.866245350159;3348.464245720722;3348.5312056312137;3362.4283871741864;6427.871442571122;6508.219013718384;6597.901031484532;6608.2730899601;6630.867382652416;6417.486601071903;6421.389967953037;6435.613863168225;6475.7085931133215;6493.837654058591;6452.419282264619;6561.212654481493;6593.912004519297;6624.370684784938;6624.56940298879;6277.340879207617;6288.056791481315;6288.151099601495;6311;6311.96844015777;6120.234970628671;6203.379662033761;6267.9373206267355;6270.216222972129;6286.64837060016;6332;6380.553361264852;6433.710483028181;6556.8360790980605;6616.437602803623;4780.976095119502;4802.759862006816;4819.614430845454;4831.516848315281;4867.440244371943;6159.260888693386;6337.9366206337345;6427.907255766438;6438.323975982455;6446.677666116581;6113.816585502442;6118.296395914349;6137.447629713347;6190.969045154746;6215.844603884758;6048.727807248596;6097;6106.755729770759;6194.81415557534;6203.0535495639215;6165.876682466236;6203.286622038523;6203.534734894811;6207.596506227081;6235.100678184666;6198;6202.968985155046;6217.564770466024;6226.034964580497;6239.344868788893;5802.187693722966;5999.280086389661;6018.3680713524445;6026.758929642765;6034.280230134391 02:45:31 INFO - PID 17109 | |5;yui.html;861.6424183963652;875.9912400875992;886.0474989386411;890.5992303463443;899.3974037394943;15822.841771582282;16311.59221019475;16323.510294691177;16564.668706625875;16696.74954875678;16037;16355.83644163558;16359.672806543891;16367.754483682755;16372.508824735247;985.2856678907806;995.6316163019675;1018.3126389686969;1021.438208985059;1021.5300961557692;1046.6859942017402;1059.2320567588513;1059.8887116852736;1059.9099076578461;1060.7666313411037;1088.1349327284827;1090.7109615951779;1091.7980173667897;1092.9234953553255;1093.7046997310722;1083.252555736547;1085.0776839686282;1085.3867564825848;1087.8477013218155;1087.9347239165675;787.3779714025912;788.3574886467568;794.2573693596506;795.6021989005498;796.4305521552118;17299.13504324779;17545;17622.383216587357;17902.820971790377;18104;18834.62330753391;18851.62296754071;19201.9039904801;19415;19433.611327773506;14227.21750303733;14674.853251467455;14839.406423743038;14842.183679897602;14862.108273503625;3327.118313646861;3333.2666813301034;3338.6828251316088;3359.96640033599;3374.207061340583;93029.53485232599;94973;95605.52197238969;95722.52138739331;96198;13410.32948352598;13595.660108497168;13700;13872.375743091585;13884.305784710725;24957.62563561548;24993.12524061649;25079;25283.62074568883;25362;7764.883526747103;7805.258500442449;7818.960905195551;7820.921790782019;7847.332976697045;3785.337565925952;3794.9430758538642;3805.7145714071557;3814.065553939303;3825.5026846509777;4568.109218702388;4672.719636821802;4674.6026587740425;5078.365204349457;5144.331236939249;946.8343039967978;966.2270183852889;967.6322997260996;974.7855471796194;981.0336818234034;708.2987842036347;718.6442710858158;731.4843035659848;742.0538813013343;755.9130699969464;11883.346415947206;13028.80456793149;13044;13066.673333166556;13111.541096061783;691.350130876974;695.6695569604398;718.8741970155306;732.2750477027704;760.2815339504226;5335.519803217729;5438.592105592096;5458.159234311265;5776.740046697909;5788.652680839163;74850;75029;75521;77510.6124469374;79375.60312198402;68219.31780682229;68396.316036839;68789.3121068783;68977.65511172412;69026.30973690198;59941.40058599445;60538.69730651318;60583;61181.69409152926;61441;11185.66443006711;11683.065354771768;11694.2983420995;11745.889832613191;11800.17398782077;32773.67226327706;32924.34151317008;32951.340973179926;33152.1711957203;34458.483122752674;39910.60089399069;39974.800126000344;40228.597714022486;40496;41177.79411102925;14923.701525969636;15048.097114173184;15110.773338400153;15170.24148792534;15300.846991529943;16306.347746090023;16671.666566668842;16799.244034018742;16826;17069.48791536256;15295.31171097281;15644.061356318658;15660.53018409404;15665.68668626644;15959.68080638404;14907.478238262043;14914.328855201325;14943.327550260481;15075.24623768829;15121.546353609408;14890.329935152728;15198;15417.383304668136;15440;15580.454684086002;10946.726331841768;10974.396408197306;11014.44927753593;11323.433828308387;11407.657770266906;11861.76276474483;12137.575184868487;12188.20776649515;12203;12347.19743216688 02:45:31 INFO - PID 17109 | __end_tp_report 02:45:31 INFO - PID 17109 | __start_cc_report 02:45:31 INFO - PID 17109 | _x_x_mozilla_cycle_collect,1543 02:45:31 INFO - PID 17109 | __end_cc_report 02:45:31 INFO - PID 17109 | __startTimestamp1493804731796__endTimestamp 02:45:31 INFO - PID 17109 | 02:45:31 INFO - PID 17109 | ------- Summary: start ------- 02:45:31 INFO - PID 17109 | Number of tests: 6 02:45:31 INFO - PID 17109 | 02:45:31 INFO - PID 17109 | [#0] dojo.html Cycles:165 Average:5805.76 Median:6099.54 stddev:800.51 (13.1%) stddev-sans-first:778.95 02:45:31 INFO - PID 17109 | Values: 3324.8 3325.1 3343.4 3356.4 3378.1 5700.1 5795.1 5820.6 5843.2 5858.4 5803.3 5834.2 5863.1 5870.6 5875.0 5118.1 5141.4 5163.4 5174.8 5192.6 5159.3 5204.5 5238.5 5242.3 5302.9 5248.8 5268.9 5280.6 5281.7 5288.1 840.2 5115.2 5177.6 5229.3 5250.8 5160.1 5165.0 5168.2 5170.1 5172.0 5698.9 5791.9 5823.1 5831.9 5855.7 6065.4 6154.0 6208.5 6271.5 6321.1 6409.6 6425.1 6428.3 6434.3 6435.7 5891.7 5910.0 5912.9 5917.5 5930.2 6285.7 6383.4 6432.5 6474.2 6532.3 6201.2 6223.9 6224.3 6233.3 6234.3 6275.5 6295.6 6318.1 6347.0 6348.4 6095.5 6171.8 6182.2 6189.9 6326.2 6223.6 6278.3 6332.5 6333.9 6339.1 4820.3 4822.1 4823.7 4835.1 4854.1 4212.7 4272.5 4273.6 4293.8 4319.9 5775.1 5878.1 5909.2 5926.6 5937.6 6324.7 6355.1 6390.6 6391.1 6397.5 5871.8 5876.9 5879.4 5900.3 5908.4 5321.2 5470.2 5474.1 5545.6 5549.6 6674.7 6687.3 6688.0 6702.9 6706.6 6368.6 6382.7 6398.4 6410.4 6413.7 6375.8 6446.8 6510.2 6525.8 6659.5 6189.2 6256.7 6262.2 6280.7 6283.1 6384.3 6390.8 6393.2 6400.2 6400.5 6045.6 6091.9 6123.5 6142.8 6183.6 6114.2 6134.2 6171.6 6174.1 6190.3 6162.4 6186.5 6196.1 6200.8 6204.1 6105.6 6123.6 6131.9 6139.8 6221.6 6050.5 6058.6 6070.5 6078.4 6099.5 02:45:31 INFO - PID 17109 | 02:45:31 INFO - PID 17109 | [#1] ext.html Cycles:180 Average:37142.75 Median:19129.15 stddev:53086.63 (277.5%) stddev-sans-first:53165.23 02:45:31 INFO - PID 17109 | Values: 753.3 803.2 821.5 1143.8 1156.0 30506.8 38095.6 39004.8 39153.6 39196.0 40830.8 41110.6 41176.0 41186.8 41243.4 5684.1 5806.5 7158.4 7200.2 7366.1 7248.4 7363.6 7365.0 7372.7 7378.0 7352.6 7398.6 7431.6 7436.2 7440.7 7272.6 7304.2 7321.0 7362.3 7403.3 7155.5 7189.0 7205.6 7207.6 7209.1 37198.4 37338.6 37450.0 37466.6 37512.0 3453.5 3483.3 3484.0 3487.2 3487.5 29107.7 29113.4 29280.1 29442.7 29446.6 3829.1 3833.3 3840.6 3851.6 3867.9 191706.0 191912.0 193122.0 193316.0 194110.0 48821.0 48964.3 49153.5 49291.3 49335.0 51098.5 51304.5 51459.2 51563.7 51585.0 15207.8 15259.5 15328.4 15329.6 15336.5 10153.3 10330.2 11995.5 12113.5 12373.8 14158.9 14209.3 14219.3 14251.9 14335.4 5405.4 5584.0 5648.7 5677.3 5700.7 1057.3 1094.9 1104.8 1107.4 1119.5 24608.8 24631.4 24784.9 24842.9 24871.3 1200.6 1201.3 1217.1 1233.4 1240.2 12975.7 13073.6 13223.9 13296.3 13359.5 218938.0 219022.0 220499.0 220727.0 221143.0 52077.7 52098.0 52153.7 52552.5 52556.0 1497.5 1509.7 1544.6 1545.1 1553.7 22943.9 23687.2 24220.5 24225.3 24235.5 39396.4 39562.8 39603.4 39620.4 39687.0 199842.0 199879.0 200541.0 201366.0 201783.0 30230.4 30319.1 34804.8 34914.5 34935.7 40907.8 40983.7 42357.8 43006.6 43060.6 29302.4 30551.8 31187.2 31266.7 32017.8 31132.5 31501.0 31524.4 31626.0 31656.7 36880.6 36910.8 36967.4 37004.4 37044.3 28794.3 29955.3 30189.2 30332.5 30770.0 24910.0 25299.6 25425.9 25649.5 25867.5 02:45:31 INFO - PID 17109 | 02:45:31 INFO - PID 17109 | [#2] jquery.html Cycles:180 Average:29488.16 Median:12292.78 stddev:74285.04 (604.3%) stddev-sans-first:74461.37 02:45:31 INFO - PID 17109 | Values: 421.5 442.9 451.2 455.9 460.8 18458.8 19627.3 20016.8 20169.8 20249.0 20524.7 20952.5 22359.7 22464.3 22529.0 5456.2 5647.3 5651.2 5653.6 5657.4 5453.9 5514.7 5570.3 5575.8 5586.7 5517.3 5533.8 5542.9 5543.3 5543.8 5469.9 5520.5 5537.8 5552.2 5561.4 5057.9 5080.7 5091.9 5098.4 5099.3 24528.9 24736.9 24768.0 24814.5 24907.4 2142.6 2176.0 2176.7 2177.5 2179.6 16927.7 17592.4 17644.3 17705.5 17751.2 2152.0 2165.1 2175.6 2196.4 2239.8 96713.0 97445.0 98134.0 98524.0 99341.0 12066.8 12353.6 12480.9 12510.9 12789.6 17483.6 17520.7 17531.0 17538.8 17600.6 8225.3 8394.9 8527.7 8599.4 8637.7 7589.1 7612.1 7850.6 7892.5 7897.8 7604.6 7807.9 7846.0 7859.8 7902.9 2151.5 2214.5 2225.9 2255.4 2256.9 1067.1 1091.6 1100.5 1105.1 1106.6 20615.2 21025.5 21042.9 21082.3 21113.4 1094.5 1097.7 1106.5 1113.7 1119.6 10750.0 11381.3 11503.2 11536.4 11562.2 439325.0 440252.0 446874.0 452358.0 452910.0 96584.0 97839.5 98318.0 98724.5 100611.0 1160.7 1216.1 1223.6 1229.0 1250.6 17480.1 17607.3 18039.5 18096.5 18235.8 46498.3 46606.0 47134.0 47247.0 48096.0 57228.7 59146.7 59239.1 59358.7 59865.7 9140.7 9402.6 9451.6 9594.9 10124.0 15144.9 15177.5 15587.5 15608.7 16491.1 12993.8 13074.6 13277.7 13582.3 13662.0 12466.5 12754.1 12825.0 12959.4 13447.1 12525.2 12841.0 12993.4 13338.2 13535.1 9301.1 9447.5 9505.4 9658.2 9667.0 12643.3 13117.3 13134.7 13145.1 13233.0 02:45:31 INFO - PID 17109 | 02:45:31 INFO - PID 17109 | [#3] mootools.html Cycles:180 Average:7214.28 Median:2381.49 stddev:4563.26 (191.6%) stddev-sans-first:4553.77 02:45:31 INFO - PID 17109 | Values: 1212.7 1353.5 1378.7 1408.9 1411.7 9341.5 10710.8 11323.3 11375.7 11377.8 11019.6 11127.3 11129.4 11130.8 11151.4 2033.7 2355.3 2389.0 2390.8 2394.8 2085.2 2297.3 2380.3 2382.7 2388.3 2354.7 2366.8 2374.3 2375.2 2376.0 2311.9 2319.9 2320.2 2322.0 2323.7 2253.7 2283.0 2287.1 2287.3 2294.5 11057.6 11103.2 11104.1 11191.9 11194.6 6363.2 6570.2 6592.8 6594.9 6598.5 3839.7 4020.4 4188.5 4212.3 4256.1 1381.5 1386.8 1393.4 1430.9 1466.7 16812.3 16813.0 16835.2 16888.7 16888.8 5386.2 5580.8 5597.1 5625.6 5746.6 13904.5 13983.7 13992.4 13999.0 14006.7 6602.4 6625.1 6625.7 6630.1 6636.3 5923.7 6006.9 6045.8 6112.6 6118.3 4307.2 4474.8 4479.4 4503.9 4577.6 1388.7 1419.3 1428.7 1435.9 1454.3 885.2 902.8 912.1 915.0 928.2 6762.3 7092.8 7317.7 7379.5 7526.6 940.2 967.8 1003.0 1020.9 1030.7 4515.4 4576.8 4682.8 4706.5 4730.1 14554.8 14801.5 15055.3 15246.4 15292.2 14669.3 14813.2 14825.1 14947.3 14963.7 8952.0 8971.5 9104.5 9143.0 9171.6 6789.5 6820.6 6844.9 6958.5 7058.9 13355.4 13426.8 13461.7 13471.3 13541.7 11866.9 13655.5 13750.6 13766.8 13858.0 9546.0 10509.3 10780.8 10813.5 10815.7 10610.6 10753.5 10800.9 10837.8 10862.0 9191.4 9193.8 9269.9 9391.8 9410.7 8699.7 8882.0 8935.2 8953.7 9061.6 8254.7 8316.7 8418.7 8420.0 8439.2 5950.7 6059.2 6070.0 6095.9 6112.0 6218.2 6353.1 6409.3 6466.0 6525.4 02:45:31 INFO - PID 17109 | 02:45:31 INFO - PID 17109 | [#4] prototype.html Cycles:180 Average:5152.27 Median:5905.25 stddev:1535.25 (26.0%) stddev-sans-first:1497.92 02:45:31 INFO - PID 17109 | Values: 421.1 425.8 426.2 436.3 437.6 5704.1 5868.7 5902.3 5908.2 5928.6 5725.8 5734.9 5757.9 5760.8 5806.5 4262.4 4345.3 4399.4 4403.3 4590.5 4389.0 4398.9 4400.3 4416.7 4422.4 4386.7 4389.3 4394.0 4397.1 4400.3 4328.5 4349.0 4368.2 4395.0 4399.3 3798.4 3809.1 3809.1 3817.4 3822.1 5593.7 5656.0 5669.7 5683.5 5689.5 5067.8 5099.0 5124.2 5127.7 5150.4 6134.4 6141.8 6150.5 6159.2 6167.3 4286.1 4291.1 4294.4 4295.5 4299.7 6172.5 6270.5 6309.5 6475.0 6499.6 4262.5 4318.2 4327.6 4339.6 4342.0 4393.8 4401.5 4403.1 4403.9 4404.7 4799.3 4858.7 5099.2 5099.8 5105.9 6090.0 6160.8 6162.1 6170.4 6191.3 1503.1 1510.7 1511.3 1515.6 1519.6 1016.5 1173.1 1207.3 1214.5 1229.4 5880.2 5890.9 5908.9 5909.6 5936.3 6177.2 6317.9 6358.0 6363.9 6372.4 5921.9 5943.8 5948.3 5972.4 5972.4 3312.7 3343.9 3348.5 3348.5 3362.4 6427.9 6508.2 6597.9 6608.3 6630.9 6417.5 6421.4 6435.6 6475.7 6493.8 6452.4 6561.2 6593.9 6624.4 6624.6 6277.3 6288.1 6288.2 6311.0 6312.0 6120.2 6203.4 6267.9 6270.2 6286.6 6332.0 6380.6 6433.7 6556.8 6616.4 4781.0 4802.8 4819.6 4831.5 4867.4 6159.3 6337.9 6427.9 6438.3 6446.7 6113.8 6118.3 6137.4 6191.0 6215.8 6048.7 6097.0 6106.8 6194.8 6203.1 6165.9 6203.3 6203.5 6207.6 6235.1 6198.0 6203.0 6217.6 6226.0 6239.3 5802.2 5999.3 6018.4 6026.8 6034.3 02:45:31 INFO - PID 17109 | 02:45:31 INFO - PID 17109 | [#5] yui.html Cycles:180 Average:18244.36 Median:19308.45 stddev:22568.58 (116.9%) stddev-sans-first:22594.14 02:45:31 INFO - PID 17109 | Values: 861.6 876.0 886.0 890.6 899.4 15822.8 16311.6 16323.5 16564.7 16696.7 16037.0 16355.8 16359.7 16367.8 16372.5 985.3 995.6 1018.3 1021.4 1021.5 1046.7 1059.2 1059.9 1059.9 1060.8 1088.1 1090.7 1091.8 1092.9 1093.7 1083.3 1085.1 1085.4 1087.8 1087.9 787.4 788.4 794.3 795.6 796.4 17299.1 17545.0 17622.4 17902.8 18104.0 18834.6 18851.6 19201.9 19415.0 19433.6 14227.2 14674.9 14839.4 14842.2 14862.1 3327.1 3333.3 3338.7 3360.0 3374.2 93029.5 94973.0 95605.5 95722.5 96198.0 13410.3 13595.7 13700.0 13872.4 13884.3 24957.6 24993.1 25079.0 25283.6 25362.0 7764.9 7805.3 7819.0 7820.9 7847.3 3785.3 3794.9 3805.7 3814.1 3825.5 4568.1 4672.7 4674.6 5078.4 5144.3 946.8 966.2 967.6 974.8 981.0 708.3 718.6 731.5 742.1 755.9 11883.3 13028.8 13044.0 13066.7 13111.5 691.4 695.7 718.9 732.3 760.3 5335.5 5438.6 5458.2 5776.7 5788.7 74850.0 75029.0 75521.0 77510.6 79375.6 68219.3 68396.3 68789.3 68977.7 69026.3 59941.4 60538.7 60583.0 61181.7 61441.0 11185.7 11683.1 11694.3 11745.9 11800.2 32773.7 32924.3 32951.3 33152.2 34458.5 39910.6 39974.8 40228.6 40496.0 41177.8 14923.7 15048.1 15110.8 15170.2 15300.8 16306.3 16671.7 16799.2 16826.0 17069.5 15295.3 15644.1 15660.5 15665.7 15959.7 14907.5 14914.3 14943.3 15075.2 15121.5 14890.3 15198.0 15417.4 15440.0 15580.5 10946.7 10974.4 11014.4 11323.4 11407.7 11861.8 12137.6 12188.2 12203.0 12347.2 02:45:31 INFO - PID 17109 | -------- Summary: end -------- 02:45:31 INFO - PID 17109 | 02:45:32 INFO - TEST-INFO | 17109: exit 0 02:45:32 INFO - TEST-OK | dromaeo_css | took 1115291ms 02:45:32 INFO - TEST-START | kraken 02:45:32 INFO - operating with platform_type : linux_ 02:45:32 INFO - Initialising browser for kraken test... 02:45:32 INFO - TEST-INFO | started process 17445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLrQkCB/profile http://localhost:55446/getInfo.html) 02:45:37 INFO - PID 17445 | __metrics Screen width/height:1600/1200 02:45:37 INFO - PID 17445 | colorDepth:24 02:45:37 INFO - PID 17445 | Browser inner width/height: 1024/695 02:45:37 INFO - PID 17445 | __metrics 02:45:38 INFO - PID 17445 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:45:38 INFO - PID 17445 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:45:39 INFO - TEST-INFO | 17445: exit 0 02:45:39 INFO - Browser initialized. 02:45:39 INFO - Running cycle 1/1 for kraken test... 02:45:39 INFO - TEST-INFO | started process 17538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLrQkCB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:51 INFO - PID 17538 | RSS: Main: 150876160 02:45:51 INFO - PID 17538 | 02:45:53 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55446/tests/kraken/driver.html?testName=audio-beat-detection) 02:45:54 INFO - PID 17538 | RSS: Main: 222740480 02:45:54 INFO - PID 17538 | 02:45:56 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55446/tests/kraken/driver.html?testName=audio-dft) 02:45:57 INFO - PID 17538 | RSS: Main: 183439360 02:45:57 INFO - PID 17538 | 02:46:00 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55446/tests/kraken/driver.html?testName=audio-fft) 02:46:00 INFO - PID 17538 | RSS: Main: 264200192 02:46:00 INFO - PID 17538 | 02:46:03 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55446/tests/kraken/driver.html?testName=audio-oscillator) 02:46:03 INFO - PID 17538 | RSS: Main: 175476736 02:46:03 INFO - PID 17538 | 02:46:05 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:46:06 INFO - PID 17538 | RSS: Main: 178335744 02:46:06 INFO - PID 17538 | 02:46:09 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55446/tests/kraken/driver.html?testName=imaging-darkroom) 02:46:09 INFO - PID 17538 | RSS: Main: 239828992 02:46:09 INFO - PID 17538 | 02:46:13 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55446/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:13 INFO - PID 17538 | RSS: Main: 257871872 02:46:13 INFO - PID 17538 | 02:46:16 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55446/tests/kraken/driver.html?testName=json-parse-financial) 02:46:17 INFO - PID 17538 | RSS: Main: 271990784 02:46:17 INFO - PID 17538 | 02:46:18 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:19 INFO - PID 17538 | RSS: Main: 203124736 02:46:19 INFO - PID 17538 | 02:46:20 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55446/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:21 INFO - PID 17538 | RSS: Main: 208965632 02:46:21 INFO - PID 17538 | 02:46:23 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:46:23 INFO - PID 17538 | RSS: Main: 218001408 02:46:23 INFO - PID 17538 | 02:46:26 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:46:27 INFO - PID 17538 | RSS: Main: 226217984 02:46:27 INFO - PID 17538 | 02:46:30 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:46:30 INFO - PID 17538 | RSS: Main: 221339648 02:46:30 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | Cycle 1(1): loaded http://localhost:55446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55446/tests/kraken/driver.html?testName=ai-astar) 02:46:32 INFO - PID 17538 | RSS: Main: 271360000 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | __start_tp_report 02:46:32 INFO - PID 17538 | _x_x_mozilla_page_load 02:46:32 INFO - PID 17538 | _x_x_mozilla_page_load_details 02:46:32 INFO - PID 17538 | |i|pagename|runs| 02:46:32 INFO - PID 17538 | |0;ai-astar;103;109;109;108;109;109;108;108;109;110 02:46:32 INFO - PID 17538 | |1;audio-beat-detection;153;116;115;161;116;116;116;117;141;117 02:46:32 INFO - PID 17538 | |2;audio-dft;161;161;161;162;160;160;162;161;163;162 02:46:32 INFO - PID 17538 | |3;audio-fft;75;74;74;108;75;73;73;79;94;77 02:46:32 INFO - PID 17538 | |4;audio-oscillator;83;83;108;82;81;81;94;82;82;106 02:46:32 INFO - PID 17538 | |5;imaging-gaussian-blur;113;113;113;113;114;114;113;113;113;112 02:46:32 INFO - PID 17538 | |6;imaging-darkroom;147;146;148;146;147;146;147;147;146;146 02:46:32 INFO - PID 17538 | |7;imaging-desaturate;94;95;93;95;95;94;94;94;94;94 02:46:32 INFO - PID 17538 | |8;json-parse-financial;44;46;44;44;47;45;46;46;46;46 02:46:32 INFO - PID 17538 | |9;json-stringify-tinderbox;54;54;54;54;54;54;55;54;54;54 02:46:32 INFO - PID 17538 | |10;stanford-crypto-aes;80;82;80;80;81;80;80;80;81;81 02:46:32 INFO - PID 17538 | |11;stanford-crypto-ccm;125;124;123;126;126;122;123;124;176;131 02:46:32 INFO - PID 17538 | |12;stanford-crypto-pbkdf2;185;179;180;181;182;181;181;181;180;178 02:46:32 INFO - PID 17538 | |13;stanford-crypto-sha256-iterative;65;64;64;64;63;66;66;65;64;64 02:46:32 INFO - PID 17538 | __end_tp_report 02:46:32 INFO - PID 17538 | __start_cc_report 02:46:32 INFO - PID 17538 | _x_x_mozilla_cycle_collect,1690 02:46:32 INFO - PID 17538 | __end_cc_report 02:46:32 INFO - PID 17538 | __startTimestamp1493804792675__endTimestamp 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | ------- Summary: start ------- 02:46:32 INFO - PID 17538 | Number of tests: 14 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:1.93 (1.8%) stddev-sans-first:0.67 02:46:32 INFO - PID 17538 | Values: 103.0 109.0 109.0 108.0 109.0 109.0 108.0 108.0 109.0 110.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:117.00 stddev:17.81 (15.2%) stddev-sans-first:16.17 02:46:32 INFO - PID 17538 | Values: 153.0 116.0 115.0 161.0 116.0 116.0 116.0 117.0 141.0 117.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 02:46:32 INFO - PID 17538 | Values: 161.0 161.0 161.0 162.0 160.0 160.0 162.0 161.0 163.0 162.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:11.59 (15.5%) stddev-sans-first:12.14 02:46:32 INFO - PID 17538 | Values: 75.0 74.0 74.0 108.0 75.0 73.0 73.0 79.0 94.0 77.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:82.00 stddev:10.62 (13.0%) stddev-sans-first:11.10 02:46:32 INFO - PID 17538 | Values: 83.0 83.0 108.0 82.0 81.0 81.0 94.0 82.0 82.0 106.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:46:32 INFO - PID 17538 | Values: 113.0 113.0 113.0 113.0 114.0 114.0 113.0 113.0 113.0 112.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:46:32 INFO - PID 17538 | Values: 147.0 146.0 148.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 02:46:32 INFO - PID 17538 | Values: 94.0 95.0 93.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#8] json-parse-financial Cycles:10 Average:45.40 Median:46.00 stddev:1.07 (2.3%) stddev-sans-first:1.01 02:46:32 INFO - PID 17538 | Values: 44.0 46.0 44.0 44.0 47.0 45.0 46.0 46.0 46.0 46.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 02:46:32 INFO - PID 17538 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 54.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:0.71 (0.9%) stddev-sans-first:0.73 02:46:32 INFO - PID 17538 | Values: 80.0 82.0 80.0 80.0 81.0 80.0 80.0 80.0 81.0 81.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:125.50 stddev:16.36 (13.0%) stddev-sans-first:17.25 02:46:32 INFO - PID 17538 | Values: 125.0 124.0 123.0 126.0 126.0 122.0 123.0 124.0 176.0 131.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:181.00 stddev:1.87 (1.0%) stddev-sans-first:1.22 02:46:32 INFO - PID 17538 | Values: 185.0 179.0 180.0 181.0 182.0 181.0 181.0 181.0 180.0 178.0 02:46:32 INFO - PID 17538 | 02:46:32 INFO - PID 17538 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 02:46:32 INFO - PID 17538 | Values: 65.0 64.0 64.0 64.0 63.0 66.0 66.0 65.0 64.0 64.0 02:46:32 INFO - PID 17538 | -------- Summary: end -------- 02:46:32 INFO - PID 17538 | 02:46:33 INFO - TEST-INFO | 17538: exit 0 02:46:33 INFO - TEST-OK | kraken | took 61321ms 02:46:33 INFO - SUITE-END | took 1176s 02:46:34 INFO - Completed test suite (00:19:36) 02:46:34 INFO - javascript benchmark 02:46:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7662.1221658440445, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.7506437017228, 3325.085601459599, 3343.364760695468, 3356.3958487472246, 3378.0879162626093, 5700.059490184115, 5795.101759227321, 5820.563457740675, 5843.211166492522, 5858.384869588695, 5803.332616749075, 5834.183214349994, 5863.149843272734, 5870.559708021894, 5875.0, 5118.053160165363, 5141.4087379951225, 5163.380394352665, 5174.844754657366, 5192.584593232532, 5159.277701121846, 5204.531592156705, 5238.47615238475, 5242.292290540785, 5302.946970530284, 5248.763805628756, 5268.946210757845, 5280.603954703393, 5281.735913204344, 5288.101022826109, 840.1771437660632, 5115.181570948667, 5177.611679124081, 5229.267902493654, 5250.789968401259, 5160.122779127557, 5165.0, 5168.173092305213, 5170.121079416508, 5171.974140129313, 5698.943010569924, 5791.940953520854, 5823.068309070529, 5831.9416805831825, 5855.736491857877, 6065.3535148213, 6153.969230153865, 6208.472279856218, 6271.498280137578, 6321.1150438938585, 6409.583377080475, 6425.1326070980285, 6428.292887782341, 6434.260060093103, 6435.710393032325, 5891.73487193073, 5910.0248459004215, 5912.881742365129, 5917.497012753878, 5930.169776231331, 6285.654289014056, 6383.39357761012, 6432.4532414744335, 6474.1907261592305, 6532.281449040602, 6201.224846894138, 6223.875522489525, 6224.315325314212, 6233.252009758858, 6234.251889773165, 6275.529335299871, 6295.559310848288, 6318.052292156213, 6346.9682651586445, 6348.4286414222015, 6095.468565591199, 6171.753129874754, 6182.227221597301, 6189.938100618936, 6326.177596912372, 6223.626582405071, 6278.277998030285, 6332.525060620472, 6333.904991425133, 6339.144215530937, 4820.305213232557, 4822.083804077214, 4823.686460380064, 4835.1296766581645, 4854.077725232195, 4212.705110642226, 4272.46594175728, 4273.55127711592, 4293.785310734451, 4319.935200971988, 5775.104858746901, 5878.11828225761, 5909.172715819789, 5926.585139040312, 5937.614055086406, 6324.716562316446, 6355.110284560165, 6390.552661313756, 6391.105245265667, 6397.52018598607, 5871.794487192928, 5876.853078673067, 5879.353271140171, 5900.291964964232, 5908.409159084057, 5321.175217841241, 5470.152126420332, 5474.069408200616, 5545.556355491551, 5549.556035517229, 6674.699638516278, 6687.264400915993, 6687.966560167168, 6702.899456508058, 6706.631135287606, 6368.617882927039, 6382.68086595659, 6398.392152745481, 6410.358964103552, 6413.7113829876835, 6375.840603984938, 6446.8388290293115, 6510.18622672166, 6525.836854078496, 6659.500537459613, 6189.195404597373, 6256.655883926428, 6262.2172228471445, 6280.717367718555, 6283.057541368831, 6384.297727249906, 6390.840228994312, 6393.168888044711, 6400.199975003125, 6400.455961243347, 6045.57680962346, 6091.908621370594, 6123.479504242189, 6142.754289828356, 6183.5671502994355, 6114.174586430775, 6134.191681014119, 6171.6297022178815, 6174.135621012972, 6190.2571691397325, 6162.383761623802, 6186.505079593711, 6196.1015652731, 6200.782972595937, 6204.069389591597, 6105.633661980295, 6123.571350005635, 6131.9272270139245, 6139.768135342541, 6221.595596286227, 6050.45545900871, 6058.57589968698, 6070.453659170696, 6078.3921607838865, 6099.542534309856], "value": 5750.2408365005895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.3483536740717, 803.1727320859515, 821.4660470694047, 1143.7769634921183, 1155.953761849526, 30506.84746576267, 38095.61904380955, 39004.80497597508, 39153.60846391535, 39196.0, 40830.7958460208, 41110.58889411105, 41176.0, 41186.7940660297, 41243.38134927971, 5684.147377893308, 5806.535477161838, 7158.355747982707, 7200.207977122525, 7366.079240094961, 7248.420126389876, 7363.5581865088, 7365.0, 7372.668229929639, 7378.040854688883, 7352.63236838156, 7398.630068496581, 7431.628418579076, 7436.1820199777985, 7440.739574114907, 7272.63636818157, 7304.196538380774, 7321.0, 7362.263773622649, 7403.2966868147705, 7155.463340249502, 7188.964055179743, 7205.603691796949, 7207.603581802999, 7209.06282183318, 37198.44202336967, 37338.62661373379, 37450.0, 37466.62533374659, 37512.0, 3453.4647129694936, 3483.303339332144, 3484.0244731474972, 3487.1630808606005, 3487.47687846825, 29107.708922910922, 29113.417731645248, 29280.121596352143, 29442.70557294421, 29446.558301625493, 3829.1193025604266, 3833.3291673956946, 3840.635139661728, 3851.5763266040713, 3867.9226415471812, 191706.0, 191912.0, 193122.0, 193316.0, 194110.0, 48821.0, 48964.265536016275, 49153.508464915605, 49291.26063109056, 49335.0, 51098.48901510937, 51304.48695513072, 51459.19892803734, 51563.74218128961, 51585.0, 15207.771883421758, 15259.542213733606, 15328.386864525293, 15329.6167595811, 15336.539903802905, 10153.340032897839, 10330.173586113093, 11995.520179192908, 12113.454894529767, 12373.814392784116, 14158.85841141596, 14209.289535523183, 14219.289035548389, 14251.928740356232, 14335.426582936774, 5405.4324295949145, 5584.0, 5648.661080335193, 5677.318721753333, 5700.686462244534, 1057.3285963413134, 1094.934303941766, 1104.7735214281054, 1107.4020029184312, 1119.5409881948362, 24608.753912461005, 24631.3842153944, 24784.876075619868, 24842.875785620956, 24871.253862384157, 1200.6158029430499, 1201.333260040686, 1217.1419149499582, 1233.3709807997986, 1240.2000709542294, 12975.675608109872, 13073.617702984056, 13223.867761322455, 13296.335183240799, 13359.465621375037, 218938.0, 219022.0, 220499.0, 220727.0, 221143.0, 52077.656505457344, 52098.0, 52153.73923130436, 52552.47447525552, 52556.0, 1497.5282785922618, 1509.7131545006414, 1544.5520798968173, 1545.0729562262777, 1553.720330340527, 22943.88528057349, 23687.1709490167, 24220.515589687755, 24225.273241802774, 24235.516429460607, 39396.40905386479, 39562.80218598888, 39603.405948910215, 39620.405693914036, 39687.0, 199842.0, 199879.0, 200541.0, 201366.0, 201783.0, 30230.395392092476, 30319.11968363002, 34804.82597586996, 34914.47628285527, 34935.65064349324, 40907.795461022506, 40983.672122623866, 42357.788211058745, 43006.569934300256, 43060.569394305654, 29302.41395172042, 30551.847240763655, 31187.220319491287, 31266.687333126378, 32017.839910800296, 31132.53301200529, 31501.0, 31524.36951261008, 31626.0, 31656.683433166294, 36880.631193688794, 36910.8154459226, 36967.44548831823, 37004.44493332656, 37044.25911481701, 28794.28014299659, 29955.251118722208, 30189.245268868453, 30332.545011824397, 30770.0, 24910.0, 25299.620505692797, 25425.87287063553, 25649.487010260065, 25867.482650347265], "value": 16871.2064527295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.51104718526517, 442.8804222859828, 451.1743509377839, 455.9316102584612, 460.84100985160126, 18458.815411845877, 19627.313044043443, 20016.799832001674, 20169.798302016974, 20249.0, 20524.692129618066, 20952.476188095305, 22359.664605030895, 22464.32607021792, 22528.986195621197, 5456.154296084113, 5647.265855438808, 5651.180578816069, 5653.575981801361, 5657.405972372903, 5453.918191227135, 5514.696691681956, 5570.275864137677, 5575.832725018256, 5586.748596313176, 5517.282753242073, 5533.810230800377, 5542.944570554303, 5543.334799824027, 5543.750531226085, 5469.863253418656, 5520.503154716095, 5537.833864984057, 5552.194931734876, 5561.360443548962, 5057.873553161164, 5080.669756465818, 5091.898162036776, 5098.439171691111, 5099.33708617881, 24528.87735561311, 24736.876315618487, 24768.0, 24814.50370992588, 24907.377315567075, 2142.5500644864596, 2176.0207906442165, 2176.7279090113734, 2177.4774054226873, 2179.6403593407226, 16927.66144677112, 17592.384266550736, 17644.294228230854, 17705.468835934815, 17751.201195946214, 2151.956960860774, 2165.07984106754, 2175.6083904897114, 2196.417949243452, 2239.7760223977634, 96713.0, 97445.0, 98134.0, 98524.0, 99341.0, 12066.75866482683, 12353.62939111828, 12480.875191247971, 12510.874891251153, 12789.552365667158, 17483.56291092733, 17520.737188942177, 17531.0, 17538.824611753975, 17600.64798704019, 8225.341972642174, 8394.874076888851, 8527.74416767498, 8599.39804213699, 8637.654493820302, 7589.1272503662785, 7612.086549614081, 7850.646720897574, 7892.526448412998, 7897.763067107996, 7604.619769011527, 7807.86785916039, 7845.960770196112, 7859.84280314402, 7902.920970790334, 2151.548174883292, 2214.4685275533757, 2225.888705564715, 2255.436140964759, 2256.943576410603, 1067.1196263082988, 1091.6070214722693, 1100.4882729530807, 1105.0605389663456, 1106.6403418888892, 20615.175392984114, 21025.474363141046, 21042.894785525976, 21082.262120825697, 21113.366599002056, 1094.480121942071, 1097.7475180708482, 1106.5186643809968, 1113.6547670222258, 1119.574561666578, 10750.002497677235, 11381.260218085798, 11503.194776365573, 11536.365499897585, 11562.248453850472, 439325.0, 440252.0, 446874.0, 452358.0, 452910.0, 96584.0, 97839.51080244695, 98318.0, 98724.50637746765, 100611.0, 1160.733031402782, 1216.0697066743949, 1223.6451429085644, 1228.993855030719, 1250.5748045664336, 17480.052328310296, 17607.29570817153, 18039.5490112743, 18096.547586310448, 18235.808733471324, 46498.30252546282, 46606.0, 47134.0, 47247.0, 48096.0, 57228.68682021713, 59146.70426648011, 59239.111413329694, 59358.70320648542, 59865.7006714981, 9140.725778226664, 9402.576884040098, 9451.621935122517, 9594.856077158709, 10124.0, 15144.924275378553, 15177.468788592347, 15587.532374028797, 15608.687826243638, 16491.09298988567, 12993.805092923803, 13074.607761767162, 13277.66805829862, 13582.25297608641, 13662.0, 12466.5013399463, 12754.107212495037, 12825.0, 12959.35203239853, 13447.125936814076, 12525.185862918881, 12841.036922230684, 12993.350332483527, 13338.199708017162, 13535.120217185851, 9301.069893010645, 9447.480388578695, 9505.42967421957, 9658.21323055237, 9666.95166524163, 12643.304618246084, 13117.34413279313, 13134.671633208864, 13145.145565538209, 13233.0], "value": 10110.065301504274, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.727136394311, 1353.546561901763, 1378.6829029323255, 1408.901376903617, 1411.6541447345403, 9341.486218258002, 10710.78578428431, 11323.32060076396, 11375.658730238085, 11377.829332559997, 11019.559217631286, 11127.276727012739, 11129.443527823616, 11130.833037504444, 11151.442427878614, 2033.6746120620703, 2355.2698663414353, 2389.032441861049, 2390.772876576731, 2394.8443351182204, 2085.228465467779, 2297.2878407693584, 2380.2621187431864, 2382.725986511556, 2388.3312672451652, 2354.7174339079247, 2366.7751563601514, 2374.263978166774, 2375.239923224569, 2376.0377047295874, 2311.8612883226974, 2319.9072037118494, 2320.153144102407, 2322.001539338084, 2323.6863023491865, 2253.740819805727, 2282.9543409131725, 2287.0508738873345, 2287.2680742162515, 2294.5410917816503, 11057.557697692082, 11103.222774405795, 11104.056155226815, 11191.888081119247, 11194.608188713437, 6363.172787537636, 6570.211574611029, 6592.835179120512, 6594.93405065948, 6598.505112116611, 3839.6736277416453, 4020.43713880057, 4188.4555007848785, 4212.262854000538, 4256.063665993476, 1381.5095641047485, 1386.8058471813954, 1393.3520912775507, 1430.8569143085713, 1466.6773309871917, 16812.32750689971, 16813.0, 16835.242414091394, 16888.746668799977, 16888.83111168897, 5386.245925570423, 5580.832575022756, 5597.132444471114, 5625.606207565513, 5746.626469279484, 13904.51334203298, 13983.720325593431, 13992.440302387995, 13999.0, 14006.71986560263, 6602.372774586406, 6625.105610742488, 6625.668716564152, 6630.071789949411, 6636.336366363325, 5923.703814809329, 6006.909896351558, 6045.818625441244, 6112.572119951561, 6118.296395914527, 4307.18163548931, 4474.821007159742, 4479.440069991251, 4503.909921801545, 4577.633789296849, 1388.7430825297151, 1419.3471003338373, 1428.6714055767231, 1435.8994870358974, 1454.338276084379, 885.2077390735385, 902.8284625921054, 912.0879120879121, 914.9771255718528, 928.2388441478058, 6762.323767623297, 7092.829683102231, 7317.670704818296, 7379.520331178456, 7526.623668816537, 940.2431043010306, 967.8209531236744, 1002.9548670309854, 1020.9489525523843, 1030.6701855406197, 4515.367848501212, 4576.771161441981, 4682.789274482657, 4706.482286948433, 4730.101280756714, 14554.781678274834, 14801.481948131765, 15055.322510487054, 15246.3901443941, 15292.158931258888, 14669.33987970544, 14813.185274809988, 14825.110493370217, 14947.327370268364, 14963.70072598542, 8951.999999999869, 8971.461712297283, 9104.499252541042, 9143.0, 9171.63313467454, 6789.490788190807, 6820.624865632438, 6844.8973265402055, 6958.512904096665, 7058.858822823412, 13355.3990070449, 13426.798598021232, 13461.663458413617, 13471.326433678472, 13541.72916541644, 11866.881331186578, 13655.453781848615, 13750.587482375544, 13766.793498097337, 13858.0, 9545.952270238604, 10509.264351495322, 10780.838287425539, 10813.513391897226, 10815.67552973412, 10610.628627997983, 10753.516091775733, 10800.891991079989, 10837.783244335227, 10862.0, 9191.402558833654, 9193.816123677356, 9269.860952085859, 9391.812163756824, 9410.717678469657, 8699.652013919373, 8882.0, 8935.195832375117, 8953.731388058368, 9061.637534498546, 8254.669813207645, 8316.708915187939, 8418.747437576883, 8420.0, 8439.156084391512, 5950.672713000827, 6059.182010428536, 6070.0, 6095.878082438415, 6112.0, 6218.160548326099, 6353.110564520878, 6409.327020662763, 6466.030095485715, 6525.412712855866], "value": 5463.733080439044, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.13877121286976, 425.77859513053215, 426.15621070280827, 436.3149854728078, 437.6323887934135, 5704.058830292996, 5868.73590688419, 5902.321233058199, 5908.172855800191, 5928.584999050068, 5725.770969161239, 5734.913976290349, 5757.942420575793, 5760.798372056979, 5806.506446952004, 4262.403263543107, 4345.283028300327, 4399.362092496586, 4403.273459879132, 4590.540945905408, 4388.956110438902, 4398.8900277493, 4400.317950717628, 4416.73499590024, 4422.447194100738, 4386.7367957922625, 4389.275769498029, 4394.033312671208, 4397.098594788061, 4400.295952647577, 4328.523862375152, 4349.0, 4368.213721530124, 4394.978025109886, 4399.296112621981, 3798.392257238856, 3809.12390150267, 3809.142942837839, 3817.4464702617965, 3822.0827001519715, 5593.664380137205, 5656.038473459522, 5669.688167150805, 5683.5169010634145, 5689.516391106761, 5067.77195026221, 5098.97450512745, 5124.2321399117245, 5127.717975511346, 5150.356205474316, 6134.4172303631085, 6141.815745527641, 6150.477209437158, 6159.168512250833, 6167.259928808527, 4286.057067445188, 4291.077418355068, 4294.398784170218, 4295.5060168080445, 4299.74201547905, 6172.537059720539, 6270.495081180484, 6309.526785491106, 6474.967625161891, 6499.610023398611, 4262.531121576686, 4318.157959197926, 4327.632151267115, 4339.587739164837, 4341.978290108593, 4393.824247030083, 4401.471823381151, 4403.053343531156, 4403.911921761547, 4404.713693609905, 4799.280107983761, 4858.708477491362, 5099.184130539096, 5099.847004589868, 5105.8723531912, 6090.0, 6160.784372547029, 6162.058951430286, 6170.352113028068, 6191.288001879841, 1503.075608500786, 1510.6752048309665, 1511.3199060422635, 1515.636247300662, 1519.6049027252993, 1016.5019140621042, 1173.1318824070297, 1207.2575366149754, 1214.5324050240722, 1229.4283158331418, 5880.176775251468, 5890.8821823563285, 5908.881822363529, 5909.556783241274, 5936.347001829795, 6177.166082578884, 6317.873642527124, 6357.96821015892, 6363.872722545523, 6372.426481616677, 5921.940780592225, 5943.81123775238, 5948.3047331510315, 5972.432618901197, 5972.432618901197, 3312.685294896981, 3343.866245350159, 3348.464245720722, 3348.5312056312137, 3362.4283871741864, 6427.871442571122, 6508.219013718384, 6597.901031484532, 6608.2730899601, 6630.867382652416, 6417.486601071903, 6421.389967953037, 6435.613863168225, 6475.7085931133215, 6493.837654058591, 6452.419282264619, 6561.212654481493, 6593.912004519297, 6624.370684784938, 6624.56940298879, 6277.340879207617, 6288.056791481315, 6288.151099601495, 6311.0, 6311.96844015777, 6120.234970628671, 6203.379662033761, 6267.9373206267355, 6270.216222972129, 6286.64837060016, 6332.0, 6380.553361264852, 6433.710483028181, 6556.8360790980605, 6616.437602803623, 4780.976095119502, 4802.759862006816, 4819.614430845454, 4831.516848315281, 4867.440244371943, 6159.260888693386, 6337.9366206337345, 6427.907255766438, 6438.323975982455, 6446.677666116581, 6113.816585502442, 6118.296395914349, 6137.447629713347, 6190.969045154746, 6215.844603884758, 6048.727807248596, 6097.0, 6106.755729770759, 6194.81415557534, 6203.0535495639215, 6165.876682466236, 6203.286622038523, 6203.534734894811, 6207.596506227081, 6235.100678184666, 6198.0, 6202.968985155046, 6217.564770466024, 6226.034964580497, 6239.344868788893, 5802.187693722966, 5999.280086389661, 6018.3680713524445, 6026.758929642765, 6034.280230134391], "value": 4688.4817553131, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [861.6424183963652, 875.9912400875992, 886.0474989386411, 890.5992303463443, 899.3974037394943, 15822.841771582282, 16311.59221019475, 16323.510294691177, 16564.668706625875, 16696.74954875678, 16037.0, 16355.83644163558, 16359.672806543891, 16367.754483682755, 16372.508824735247, 985.2856678907806, 995.6316163019675, 1018.3126389686969, 1021.438208985059, 1021.5300961557692, 1046.6859942017402, 1059.2320567588513, 1059.8887116852736, 1059.9099076578461, 1060.7666313411037, 1088.1349327284827, 1090.7109615951779, 1091.7980173667897, 1092.9234953553255, 1093.7046997310722, 1083.252555736547, 1085.0776839686282, 1085.3867564825848, 1087.8477013218155, 1087.9347239165675, 787.3779714025912, 788.3574886467568, 794.2573693596506, 795.6021989005498, 796.4305521552118, 17299.13504324779, 17545.0, 17622.383216587357, 17902.820971790377, 18104.0, 18834.62330753391, 18851.62296754071, 19201.9039904801, 19415.0, 19433.611327773506, 14227.21750303733, 14674.853251467455, 14839.406423743038, 14842.183679897602, 14862.108273503625, 3327.118313646861, 3333.2666813301034, 3338.6828251316088, 3359.96640033599, 3374.207061340583, 93029.53485232599, 94973.0, 95605.52197238969, 95722.52138739331, 96198.0, 13410.32948352598, 13595.660108497168, 13700.0, 13872.375743091585, 13884.305784710725, 24957.62563561548, 24993.12524061649, 25079.0, 25283.62074568883, 25362.0, 7764.883526747103, 7805.258500442449, 7818.960905195551, 7820.921790782019, 7847.332976697045, 3785.337565925952, 3794.9430758538642, 3805.7145714071557, 3814.065553939303, 3825.5026846509777, 4568.109218702388, 4672.719636821802, 4674.6026587740425, 5078.365204349457, 5144.331236939249, 946.8343039967978, 966.2270183852889, 967.6322997260996, 974.7855471796194, 981.0336818234034, 708.2987842036347, 718.6442710858158, 731.4843035659848, 742.0538813013343, 755.9130699969464, 11883.346415947206, 13028.80456793149, 13044.0, 13066.673333166556, 13111.541096061783, 691.350130876974, 695.6695569604398, 718.8741970155306, 732.2750477027704, 760.2815339504226, 5335.519803217729, 5438.592105592096, 5458.159234311265, 5776.740046697909, 5788.652680839163, 74850.0, 75029.0, 75521.0, 77510.6124469374, 79375.60312198402, 68219.31780682229, 68396.316036839, 68789.3121068783, 68977.65511172412, 69026.30973690198, 59941.40058599445, 60538.69730651318, 60583.0, 61181.69409152926, 61441.0, 11185.66443006711, 11683.065354771768, 11694.2983420995, 11745.889832613191, 11800.17398782077, 32773.67226327706, 32924.34151317008, 32951.340973179926, 33152.1711957203, 34458.483122752674, 39910.60089399069, 39974.800126000344, 40228.597714022486, 40496.0, 41177.79411102925, 14923.701525969636, 15048.097114173184, 15110.773338400153, 15170.24148792534, 15300.846991529943, 16306.347746090023, 16671.666566668842, 16799.244034018742, 16826.0, 17069.48791536256, 15295.31171097281, 15644.061356318658, 15660.53018409404, 15665.68668626644, 15959.68080638404, 14907.478238262043, 14914.328855201325, 14943.327550260481, 15075.24623768829, 15121.546353609408, 14890.329935152728, 15198.0, 15417.383304668136, 15440.0, 15580.454684086002, 10946.726331841768, 10974.396408197306, 11014.44927753593, 11323.433828308387, 11407.657770266906, 11861.76276474483, 12137.575184868487, 12188.20776649515, 12203.0, 12347.19743216688], "value": 8052.976160827902, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1473.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 109.0, 108.0, 109.0, 109.0, 108.0, 108.0, 109.0, 110.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 116.0, 115.0, 161.0, 116.0, 116.0, 116.0, 117.0, 141.0, 117.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 160.0, 160.0, 162.0, 161.0, 163.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 108.0, 75.0, 73.0, 73.0, 79.0, 94.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 82.0, 81.0, 81.0, 94.0, 82.0, 82.0, 106.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 112.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 46.0, 44.0, 44.0, 47.0, 45.0, 46.0, 46.0, 46.0, 46.0], "value": 45.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 80.0, 80.0, 81.0, 80.0, 80.0, 80.0, 81.0, 81.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 123.0, 126.0, 126.0, 122.0, 123.0, 124.0, 176.0, 131.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 179.0, 180.0, 181.0, 182.0, 181.0, 181.0, 181.0, 180.0, 178.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 63.0, 66.0, 66.0, 65.0, 64.0, 64.0], "value": 64.5, "unit": "score"}]}]} 02:46:34 INFO - Return code: 0 02:46:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:46:34 INFO - # TBPL SUCCESS # 02:46:34 INFO - Running post-action listener: _resource_record_post_action 02:46:34 INFO - [mozharness: 2017-05-03 09:46:34.476292Z] Finished run-tests step (success) 02:46:34 INFO - Running post-run listener: _resource_record_post_run 02:46:34 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370098176; Read time: 12; Write time: 350440 02:46:34 INFO - TinderboxPrint: CPU usage
12.9% 02:46:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:46:34 INFO - TinderboxPrint: I/O write bytes / time
370,098,176 / 350,440 02:46:34 INFO - TinderboxPrint: CPU idle
8,292.2 (87.1%) 02:46:34 INFO - TinderboxPrint: CPU user
1,185.3 (12.4%) 02:46:34 INFO - TinderboxPrint: Swap in / out
0 / 0 02:46:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112529408; Read time: 0; Write time: 144028 02:46:34 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 243900416; Read time: 0; Write time: 199196 02:46:35 INFO - Running post-run listener: _upload_blobber_files 02:46:35 INFO - Blob upload gear active. 02:46:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:46:35 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 02:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:46:35 INFO - (blobuploader) - INFO - Open directory for files ... 02:46:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:46:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:36 INFO - (blobuploader) - INFO - Done attempting. 02:46:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:46:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:39 INFO - (blobuploader) - INFO - Done attempting. 02:46:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:46:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:46:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:40 INFO - (blobuploader) - INFO - Done attempting. 02:46:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:46:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:46:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:40 INFO - (blobuploader) - INFO - Done attempting. 02:46:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:46:40 INFO - Return code: 0 02:46:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:46:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:46:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc7b2dc1512fa7d7d398d98b9577d0e6442172e2b2229915fc49726a0e9689fbc7cac943b8e044d0957f4b38d0a28f20ef038bef856d4dba28bc158307225e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ecd5b6b738b8c72bc0f8577931bc1eac7b608ab7b1813723d1d743dd6b1e1cb8fda92bcb2746c68bc03c1d6c1c180350add2c8741e07fe413da31969a2ad10", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ccf64b879cae059f43d5fcc8ff892edf2493071b46d30cb70a4e91eb2489591afb4e85e89a0ac2d471c4d1d312e51dda3aa3314fe45b23dc6c9b389e394e563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84cc70263f6dc8233a1d09246f3136ae3e674b1d0223fe45b41aec854da47eca22ffe47ec980569889f8bb083048fa728d2002621fc31975a0eaf126568dcf4e"} 02:46:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:46:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:46:40 INFO - Contents: 02:46:40 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc7b2dc1512fa7d7d398d98b9577d0e6442172e2b2229915fc49726a0e9689fbc7cac943b8e044d0957f4b38d0a28f20ef038bef856d4dba28bc158307225e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ecd5b6b738b8c72bc0f8577931bc1eac7b608ab7b1813723d1d743dd6b1e1cb8fda92bcb2746c68bc03c1d6c1c180350add2c8741e07fe413da31969a2ad10", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ccf64b879cae059f43d5fcc8ff892edf2493071b46d30cb70a4e91eb2489591afb4e85e89a0ac2d471c4d1d312e51dda3aa3314fe45b23dc6c9b389e394e563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84cc70263f6dc8233a1d09246f3136ae3e674b1d0223fe45b41aec854da47eca22ffe47ec980569889f8bb083048fa728d2002621fc31975a0eaf126568dcf4e"} 02:46:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:46:40 INFO - Copying logs to upload dir... 02:46:40 INFO - mkdir: /builds/slave/test/build/upload/logs 02:46:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.095987 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-03 02:46:40.601713) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:40.609562) ========= 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=df17445c3590ff7897617a0e00000225-1493803550.345958-710848337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc7b2dc1512fa7d7d398d98b9577d0e6442172e2b2229915fc49726a0e9689fbc7cac943b8e044d0957f4b38d0a28f20ef038bef856d4dba28bc158307225e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ecd5b6b738b8c72bc0f8577931bc1eac7b608ab7b1813723d1d743dd6b1e1cb8fda92bcb2746c68bc03c1d6c1c180350add2c8741e07fe413da31969a2ad10", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ccf64b879cae059f43d5fcc8ff892edf2493071b46d30cb70a4e91eb2489591afb4e85e89a0ac2d471c4d1d312e51dda3aa3314fe45b23dc6c9b389e394e563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84cc70263f6dc8233a1d09246f3136ae3e674b1d0223fe45b41aec854da47eca22ffe47ec980569889f8bb083048fa728d2002621fc31975a0eaf126568dcf4e"} build_url:https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/RLhhxqQ_SKC77_0XvfS-VA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc7b2dc1512fa7d7d398d98b9577d0e6442172e2b2229915fc49726a0e9689fbc7cac943b8e044d0957f4b38d0a28f20ef038bef856d4dba28bc158307225e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ecd5b6b738b8c72bc0f8577931bc1eac7b608ab7b1813723d1d743dd6b1e1cb8fda92bcb2746c68bc03c1d6c1c180350add2c8741e07fe413da31969a2ad10", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ccf64b879cae059f43d5fcc8ff892edf2493071b46d30cb70a4e91eb2489591afb4e85e89a0ac2d471c4d1d312e51dda3aa3314fe45b23dc6c9b389e394e563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84cc70263f6dc8233a1d09246f3136ae3e674b1d0223fe45b41aec854da47eca22ffe47ec980569889f8bb083048fa728d2002621fc31975a0eaf126568dcf4e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:40.634407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:40.634690) ========= 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=df17445c3590ff7897617a0e00000225-1493803550.345958-710848337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:40.719876) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 02:46:40.720169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 02:46:40.723454) ========= ========= Total master_lag: 0.26 =========