builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1485243113.7 results: success (0) buildid: 20170123213845 builduid: 36854ff7c20b40b89cba9e3d0f263bf4 revision: 7443e9844412b8645aafbc9654a6da7adc65cb30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.702863) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.703327) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.703752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.811680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.812047) ========= 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=523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-23 23:31:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2017-01-23 23:31:54 (35.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.962323) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.962716) ========= 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=523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020971 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:54.014176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:54.014534) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7443e9844412b8645aafbc9654a6da7adc65cb30 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7443e9844412b8645aafbc9654a6da7adc65cb30 --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=523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-23 23:31:54,206 truncating revision to first 12 chars 2017-01-23 23:31:54,206 Setting DEBUG logging. 2017-01-23 23:31:54,206 attempt 1/10 2017-01-23 23:31:54,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7443e9844412?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 23:31:54,537 unpacking tar archive at: mozilla-beta-7443e9844412/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:54.669930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:54.670285) ========= script_repo_revision: 7443e9844412b8645aafbc9654a6da7adc65cb30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:54.670893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:54.671210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:54.680929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-01-23 23:31:54.681331) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:31:54 INFO - MultiFileLogger online at 20170123 23:31:54 in /builds/slave/test 23:31:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:31:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:31:54 INFO - {'append_to_log': False, 23:31:54 INFO - 'base_work_dir': '/builds/slave/test', 23:31:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:31:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:31:54 INFO - 'branch': 'Mozilla-Beta', 23:31:54 INFO - 'buildbot_json_path': 'buildprops.json', 23:31:54 INFO - 'config_files': ('talos/linux_config.py',), 23:31:54 INFO - 'default_actions': ('clobber', 23:31:54 INFO - 'read-buildbot-config', 23:31:54 INFO - 'download-and-extract', 23:31:54 INFO - 'populate-webroot', 23:31:54 INFO - 'create-virtualenv', 23:31:54 INFO - 'install', 23:31:54 INFO - 'run-tests'), 23:31:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:31:54 INFO - 'download_minidump_stackwalk': True, 23:31:54 INFO - 'download_symbols': 'ondemand', 23:31:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:31:54 INFO - 'tooltool.py': '/tools/tooltool.py', 23:31:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:31:54 INFO - '/tools/misc-python/virtualenv.py')}, 23:31:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:31:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:31:54 INFO - 'installer_path': 'installer.exe', 23:31:54 INFO - 'log_level': 'info', 23:31:54 INFO - 'log_name': 'talos', 23:31:54 INFO - 'log_to_console': True, 23:31:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:31:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:31:54 INFO - 'opt_config_files': (), 23:31:54 INFO - 'pip_index': False, 23:31:54 INFO - 'sps_profile': False, 23:31:54 INFO - 'sps_profile_interval': 0, 23:31:54 INFO - 'suite': 'dromaeojs-e10s', 23:31:54 INFO - 'system_bits': '32', 23:31:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:31:54 INFO - 'title': 'talos-linux64-ix-065', 23:31:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:31:54 INFO - 'use_talos_json': True, 23:31:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:31:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:31:54 INFO - 'work_dir': 'build'} 23:31:54 INFO - [mozharness: 2017-01-24 07:31:54.966230Z] Running clobber step. 23:31:54 INFO - Running pre-action listener: _resource_record_pre_action 23:31:54 INFO - Running main action method: clobber 23:31:54 INFO - rmtree: /builds/slave/test/build 23:31:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:31:55 INFO - Running post-action listener: _resource_record_post_action 23:31:55 INFO - [mozharness: 2017-01-24 07:31:55.950585Z] Finished clobber step (success) 23:31:55 INFO - [mozharness: 2017-01-24 07:31:55.950684Z] Running read-buildbot-config step. 23:31:55 INFO - Running pre-action listener: _resource_record_pre_action 23:31:55 INFO - Running main action method: read_buildbot_config 23:31:55 INFO - Using buildbot properties: 23:31:55 INFO - { 23:31:55 INFO - "project": "", 23:31:55 INFO - "product": "firefox", 23:31:55 INFO - "script_repo_revision": "production", 23:31:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:31:55 INFO - "repository": "", 23:31:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:31:55 INFO - "buildid": "20170123213845", 23:31:55 INFO - "pgo_build": "True", 23:31:55 INFO - "basedir": "/builds/slave/test", 23:31:55 INFO - "buildnumber": 312, 23:31:55 INFO - "slavename": "talos-linux64-ix-065", 23:31:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:31:55 INFO - "platform": "ubuntu64_hw", 23:31:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:31:55 INFO - "branch": "mozilla-beta", 23:31:55 INFO - "repo_path": "releases/mozilla-beta", 23:31:55 INFO - "revision": "7443e9844412b8645aafbc9654a6da7adc65cb30", 23:31:55 INFO - "stage_platform": "linux64-pgo", 23:31:55 INFO - "builduid": "36854ff7c20b40b89cba9e3d0f263bf4", 23:31:55 INFO - "slavebuilddir": "test" 23:31:55 INFO - } 23:31:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 23:31:55 INFO - Running post-action listener: _resource_record_post_action 23:31:55 INFO - [mozharness: 2017-01-24 07:31:55.953099Z] Finished read-buildbot-config step (success) 23:31:55 INFO - [mozharness: 2017-01-24 07:31:55.953186Z] Running download-and-extract step. 23:31:55 INFO - Running pre-action listener: _resource_record_pre_action 23:31:55 INFO - Running main action method: download_and_extract 23:31:55 INFO - mkdir: /builds/slave/test/build/tests 23:31: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')]} 23:31:55 INFO - trying https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:31:55 INFO - Downloading https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:31:56 INFO - Downloaded 1327 bytes. 23:31:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:31:56 INFO - Using the following test package requirements: 23:31:56 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:31:56 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:56 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:31:56 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:56 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 23:31:56 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:56 INFO - u'jsshell-linux-x86_64.zip'], 23:31:56 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:56 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:31:56 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:31:56 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:56 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 23:31:56 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:56 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 23:31:56 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:56 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:31:56 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:56 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:31:56 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:31:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:31:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:31:56 INFO - Fetch https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:31:57 INFO - Http code: 200 23:31:57 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 23:31:57 INFO - x-amz-cf-id: qoq4r40kF1E0k6i2T4vALJsNEvPF1RWRyuHAnbIiNTGmMYUSssuRXQ== 23:31:57 INFO - x-amz-version-id: 4Op0Url43B_SHW9nt0Wqe6mKVd8Czora 23:31:57 INFO - Expected file size: 21950671 23:31:57 INFO - Obtained file size: 21950671 23:32:01 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:32:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:32:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:32:01 INFO - Fetch https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:32:02 INFO - Http code: 200 23:32:02 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 23:32:02 INFO - x-amz-cf-id: yLn4MVoyNtozkZBd4W_oBOiHpMwH0UE-XvItiNXQinBIpqIdbWMItQ== 23:32:02 INFO - x-amz-version-id: 4Op0Url43B_SHW9nt0Wqe6mKVd8Czora 23:32:02 INFO - Expected file size: 21950671 23:32:02 INFO - Obtained file size: 21950671 23:32:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 23:32:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:32:07 INFO - Fetch https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 23:32:07 INFO - Http code: 200 23:32:07 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 23:32:07 INFO - x-amz-cf-id: PaElwzwIvy4hbYTKcwvJjeUMjSOEiSJEZRozdQGIrEvkbuz6ZegmMg== 23:32:07 INFO - x-amz-version-id: cxJluqb2jvdVxHHI5DsDN2vLWf9C0hMl 23:32:08 INFO - Expected file size: 14402992 23:32:08 INFO - Obtained file size: 14402992 23:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:08 INFO - trying https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:32:08 INFO - Downloading https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:32:10 INFO - Downloaded 57682179 bytes. 23:32:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:32:10 INFO - mkdir: /builds/slave/test/properties 23:32:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:32:10 INFO - Writing to file /builds/slave/test/properties/build_url 23:32:10 INFO - Contents: 23:32:10 INFO - build_url:https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:32:11 INFO - Running post-action listener: _resource_record_post_action 23:32:11 INFO - Running post-action listener: set_extra_try_arguments 23:32:11 INFO - [mozharness: 2017-01-24 07:32:11.355616Z] Finished download-and-extract step (success) 23:32:11 INFO - [mozharness: 2017-01-24 07:32:11.355852Z] Running populate-webroot step. 23:32:11 INFO - Running pre-action listener: _resource_record_pre_action 23:32:11 INFO - Running main action method: populate_webroot 23:32:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:32:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:32:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:32:11 INFO - '--tppagecycles', 23:32:11 INFO - '7'], 23:32:11 INFO - 'tests': ['tsvgm']}}, 23:32:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:32:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:32:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:32:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:32:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:11 INFO - 'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:32:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:32:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:11 INFO - 'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['damp', 'tps']}, 23:32:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:11 INFO - 'tests': ['damp', 'tps']}, 23:32:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['dromaeo_dom']}, 23:32:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:32:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['basic_compositor_video']}, 23:32:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:32:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['a11yr', 23:32:11 INFO - 'ts_paint', 23:32:11 INFO - 'tpaint', 23:32:11 INFO - 'sessionrestore', 23:32:11 INFO - 'sessionrestore_no_auto_restore', 23:32:11 INFO - 'tabpaint']}, 23:32:11 INFO - 'other-e10s': {'tests': ['a11yr', 23:32:11 INFO - 'ts_paint', 23:32:11 INFO - 'tpaint', 23:32:11 INFO - 'sessionrestore', 23:32:11 INFO - 'sessionrestore_no_auto_restore', 23:32:11 INFO - 'tabpaint']}, 23:32:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:32:11 INFO - 'ts_paint', 23:32:11 INFO - 'tpaint', 23:32:11 INFO - 'sessionrestore', 23:32:11 INFO - 'sessionrestore_no_auto_restore', 23:32:11 INFO - 'tabpaint']}, 23:32:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:32:11 INFO - 'ts_paint', 23:32:11 INFO - 'tpaint', 23:32:11 INFO - 'sessionrestore', 23:32:11 INFO - 'sessionrestore_no_auto_restore', 23:32:11 INFO - 'tabpaint']}, 23:32:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['a11yr', 23:32:11 INFO - 'ts_paint', 23:32:11 INFO - 'tpaint', 23:32:11 INFO - 'sessionrestore', 23:32:11 INFO - 'sessionrestore_no_auto_restore', 23:32:11 INFO - 'tabpaint']}, 23:32:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['a11yr', 23:32:11 INFO - 'ts_paint', 23:32:11 INFO - 'tpaint', 23:32:11 INFO - 'sessionrestore', 23:32:11 INFO - 'sessionrestore_no_auto_restore', 23:32:11 INFO - 'tabpaint']}, 23:32:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['tsvgx', 23:32:11 INFO - 'tsvgr_opacity', 23:32:11 INFO - 'tart', 23:32:11 INFO - 'tscrollx', 23:32:11 INFO - 'cart']}, 23:32:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:32:11 INFO - 'tsvgr_opacity', 23:32:11 INFO - 'tart', 23:32:11 INFO - 'tscrollx', 23:32:11 INFO - 'cart']}, 23:32:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:11 INFO - 'talos_options': ['--disable-e10s'], 23:32:11 INFO - 'tests': ['tp5o']}, 23:32:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:11 INFO - 'tests': ['tp5o']}, 23:32:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:11 INFO - 'talos_options': ['--disable-e10s', 23:32:11 INFO - '--xperf_path', 23:32:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:32:11 INFO - 'tests': ['tp5n']}, 23:32:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:11 INFO - 'talos_options': ['--xperf_path', 23:32:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:32:11 INFO - 'tests': ['tp5n']}}, 23:32:11 INFO - 'talos.zip': {'path': '', 23:32:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:32:11 INFO - Running post-action listener: _resource_record_post_action 23:32:11 INFO - [mozharness: 2017-01-24 07:32:11.375254Z] Finished populate-webroot step (success) 23:32:11 INFO - [mozharness: 2017-01-24 07:32:11.375342Z] Running create-virtualenv step. 23:32:11 INFO - Running pre-action listener: _resource_record_pre_action 23:32:11 INFO - Running main action method: create_virtualenv 23:32:11 INFO - Creating virtualenv /builds/slave/test/build/venv 23:32:11 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 23:32:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:32:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:32:11 INFO - Using real prefix '/usr' 23:32:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:32:11 INFO - Installing distribute.............................................................................................................................................................................................done. 23:32:13 INFO - Installing pip.................done. 23:32:13 INFO - Return code: 0 23:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:32:14 INFO - Reading from file tmpfile_stdout 23:32:14 INFO - Output received: 23:32:14 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) 23:32:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:14 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 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:14 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 23:32:14 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 23:32:14 INFO - Using env: {'DISPLAY': ':0', 23:32:14 INFO - 'HOME': '/home/cltbld', 23:32:14 INFO - 'LANG': 'en_US.UTF-8', 23:32:14 INFO - 'LANGUAGE': 'en_US:en', 23:32:14 INFO - 'LOGNAME': 'cltbld', 23:32:14 INFO - 'MAIL': '/var/mail/cltbld', 23:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:14 INFO - 'MOZ_NO_REMOTE': '1', 23:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:14 INFO - 'NO_EM_RESTART': '1', 23:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:14 INFO - 'PWD': '/builds/slave/test', 23:32:14 INFO - 'SHELL': '/bin/bash', 23:32:14 INFO - 'SHLVL': '1', 23:32:14 INFO - 'TERM': 'linux', 23:32:14 INFO - 'TMOUT': '86400', 23:32:14 INFO - 'USER': 'cltbld', 23:32:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:14 INFO - '_': '/tools/buildbot/bin/python'} 23:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:14 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 23:32:14 INFO - Cleaning up... 23:32:14 INFO - Return code: 0 23:32:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:14 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 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:14 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 23:32:14 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 23:32:14 INFO - Using env: {'DISPLAY': ':0', 23:32:14 INFO - 'HOME': '/home/cltbld', 23:32:14 INFO - 'LANG': 'en_US.UTF-8', 23:32:14 INFO - 'LANGUAGE': 'en_US:en', 23:32:14 INFO - 'LOGNAME': 'cltbld', 23:32:14 INFO - 'MAIL': '/var/mail/cltbld', 23:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:14 INFO - 'MOZ_NO_REMOTE': '1', 23:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:14 INFO - 'NO_EM_RESTART': '1', 23:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:14 INFO - 'PWD': '/builds/slave/test', 23:32:14 INFO - 'SHELL': '/bin/bash', 23:32:14 INFO - 'SHLVL': '1', 23:32:14 INFO - 'TERM': 'linux', 23:32:14 INFO - 'TMOUT': '86400', 23:32:14 INFO - 'USER': 'cltbld', 23:32:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:14 INFO - '_': '/tools/buildbot/bin/python'} 23:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:14 INFO - Downloading/unpacking psutil>=3.1.1 23:32:14 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 23:32:14 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 23:32:14 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 23:32:14 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 23:32:14 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 23:32:14 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 23:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:32:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:32:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:32:16 INFO - Installing collected packages: psutil 23:32:16 INFO - Running setup.py install for psutil 23:32:17 INFO - building 'psutil._psutil_linux' extension 23:32:17 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 23:32:17 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 23:32:17 INFO - building 'psutil._psutil_posix' extension 23:32:17 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 23:32:17 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 23:32:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:32:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:32:17 INFO - Successfully installed psutil 23:32:17 INFO - Cleaning up... 23:32:17 INFO - Return code: 0 23:32:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:17 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 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:17 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 23:32:17 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 23:32:17 INFO - Using env: {'DISPLAY': ':0', 23:32:17 INFO - 'HOME': '/home/cltbld', 23:32:17 INFO - 'LANG': 'en_US.UTF-8', 23:32:17 INFO - 'LANGUAGE': 'en_US:en', 23:32:17 INFO - 'LOGNAME': 'cltbld', 23:32:17 INFO - 'MAIL': '/var/mail/cltbld', 23:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:17 INFO - 'MOZ_NO_REMOTE': '1', 23:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:17 INFO - 'NO_EM_RESTART': '1', 23:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:17 INFO - 'PWD': '/builds/slave/test', 23:32:17 INFO - 'SHELL': '/bin/bash', 23:32:17 INFO - 'SHLVL': '1', 23:32:17 INFO - 'TERM': 'linux', 23:32:17 INFO - 'TMOUT': '86400', 23:32:17 INFO - 'USER': 'cltbld', 23:32:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:17 INFO - '_': '/tools/buildbot/bin/python'} 23:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:32:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:32:19 INFO - Installing collected packages: mozsystemmonitor 23:32:19 INFO - Running setup.py install for mozsystemmonitor 23:32:19 INFO - Successfully installed mozsystemmonitor 23:32:19 INFO - Cleaning up... 23:32:19 INFO - Return code: 0 23:32:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:32:19 INFO - Using env: {'DISPLAY': ':0', 23:32:19 INFO - 'HOME': '/home/cltbld', 23:32:19 INFO - 'LANG': 'en_US.UTF-8', 23:32:19 INFO - 'LANGUAGE': 'en_US:en', 23:32:19 INFO - 'LOGNAME': 'cltbld', 23:32:19 INFO - 'MAIL': '/var/mail/cltbld', 23:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:19 INFO - 'MOZ_NO_REMOTE': '1', 23:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:19 INFO - 'NO_EM_RESTART': '1', 23:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:19 INFO - 'PWD': '/builds/slave/test', 23:32:19 INFO - 'SHELL': '/bin/bash', 23:32:19 INFO - 'SHLVL': '1', 23:32:19 INFO - 'TERM': 'linux', 23:32:19 INFO - 'TMOUT': '86400', 23:32:19 INFO - 'USER': 'cltbld', 23:32:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:19 INFO - '_': '/tools/buildbot/bin/python'} 23:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:20 INFO - Downloading/unpacking jsonschema==2.5.1 23:32:20 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 23:32:20 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 23:32:20 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 23:32:20 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 23:32:20 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 23:32:20 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 23:32:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:32:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:32:22 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 23:32:22 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 23:32:22 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 23:32:22 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 23:32:22 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 23:32:22 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 23:32:22 INFO - Downloading functools32-3.2.3-2.tar.gz 23:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:32:22 INFO - warning: no files found matching '*.txt' 23:32:22 INFO - no previously-included directories found matching 'build' 23:32:22 INFO - no previously-included directories found matching 'dist' 23:32:22 INFO - no previously-included directories found matching '.git*' 23:32:22 INFO - Installing collected packages: jsonschema, functools32 23:32:22 INFO - Running setup.py install for functools32 23:32:22 INFO - warning: no files found matching '*.txt' 23:32:22 INFO - no previously-included directories found matching 'build' 23:32:22 INFO - no previously-included directories found matching 'dist' 23:32:22 INFO - no previously-included directories found matching '.git*' 23:32:22 INFO - Successfully installed jsonschema functools32 23:32:22 INFO - Cleaning up... 23:32:22 INFO - Return code: 0 23:32:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:32:22 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')]} 23:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:22 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')]} 23:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:22 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 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:22 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 23:32:22 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 23:32:22 INFO - Using env: {'DISPLAY': ':0', 23:32:22 INFO - 'HOME': '/home/cltbld', 23:32:22 INFO - 'LANG': 'en_US.UTF-8', 23:32:22 INFO - 'LANGUAGE': 'en_US:en', 23:32:22 INFO - 'LOGNAME': 'cltbld', 23:32:22 INFO - 'MAIL': '/var/mail/cltbld', 23:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:22 INFO - 'MOZ_NO_REMOTE': '1', 23:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:22 INFO - 'NO_EM_RESTART': '1', 23:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:22 INFO - 'PWD': '/builds/slave/test', 23:32:22 INFO - 'SHELL': '/bin/bash', 23:32:22 INFO - 'SHLVL': '1', 23:32:22 INFO - 'TERM': 'linux', 23:32:22 INFO - 'TMOUT': '86400', 23:32:22 INFO - 'USER': 'cltbld', 23:32:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:22 INFO - '_': '/tools/buildbot/bin/python'} 23:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:32:22 INFO - Cleaning up... 23:32:22 INFO - Return code: 0 23:32:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:32:22 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')]} 23:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:22 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')]} 23:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:22 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 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:22 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 23:32:22 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 23:32:22 INFO - Using env: {'DISPLAY': ':0', 23:32:22 INFO - 'HOME': '/home/cltbld', 23:32:22 INFO - 'LANG': 'en_US.UTF-8', 23:32:22 INFO - 'LANGUAGE': 'en_US:en', 23:32:22 INFO - 'LOGNAME': 'cltbld', 23:32:22 INFO - 'MAIL': '/var/mail/cltbld', 23:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:22 INFO - 'MOZ_NO_REMOTE': '1', 23:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:22 INFO - 'NO_EM_RESTART': '1', 23:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:22 INFO - 'PWD': '/builds/slave/test', 23:32:22 INFO - 'SHELL': '/bin/bash', 23:32:22 INFO - 'SHLVL': '1', 23:32:22 INFO - 'TERM': 'linux', 23:32:22 INFO - 'TMOUT': '86400', 23:32:22 INFO - 'USER': 'cltbld', 23:32:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:22 INFO - '_': '/tools/buildbot/bin/python'} 23:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:23 INFO - Downloading/unpacking blobuploader==1.2.4 23:32:23 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 23:32:23 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 23:32:23 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 23:32:23 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 23:32:23 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 23:32:23 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 23:32:25 INFO - Downloading blobuploader-1.2.4.tar.gz 23:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:32:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:32: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 23:32: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 23:32: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 23:32: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 23:32: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 23:32: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 23:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:32:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:32: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 23:32: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 23:32: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 23:32: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 23:32: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 23:32: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 23:32:25 INFO - Downloading docopt-0.6.1.tar.gz 23:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:32:25 INFO - Installing collected packages: blobuploader, requests, docopt 23:32:25 INFO - Running setup.py install for blobuploader 23:32:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:32:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:32:25 INFO - Running setup.py install for requests 23:32:26 INFO - Running setup.py install for docopt 23:32:26 INFO - Successfully installed blobuploader requests docopt 23:32:26 INFO - Cleaning up... 23:32:26 INFO - Return code: 0 23:32:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:32: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')]} 23:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32: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')]} 23:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:26 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 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:26 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 23:32:26 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 23:32:26 INFO - Using env: {'DISPLAY': ':0', 23:32:26 INFO - 'HOME': '/home/cltbld', 23:32:26 INFO - 'LANG': 'en_US.UTF-8', 23:32:26 INFO - 'LANGUAGE': 'en_US:en', 23:32:26 INFO - 'LOGNAME': 'cltbld', 23:32:26 INFO - 'MAIL': '/var/mail/cltbld', 23:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:26 INFO - 'MOZ_NO_REMOTE': '1', 23:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:26 INFO - 'NO_EM_RESTART': '1', 23:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:26 INFO - 'PWD': '/builds/slave/test', 23:32:26 INFO - 'SHELL': '/bin/bash', 23:32:26 INFO - 'SHLVL': '1', 23:32:26 INFO - 'TERM': 'linux', 23:32:26 INFO - 'TMOUT': '86400', 23:32:26 INFO - 'USER': 'cltbld', 23:32:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:26 INFO - '_': '/tools/buildbot/bin/python'} 23:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:32:26 INFO - Running setup.py (path:/tmp/pip-uX_172-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:32:26 INFO - Running setup.py (path:/tmp/pip-Pys_rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:32:26 INFO - Running setup.py (path:/tmp/pip-G3fkMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:32:26 INFO - Running setup.py (path:/tmp/pip-u95KAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:32:27 INFO - Running setup.py (path:/tmp/pip-TUrV3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:32:27 INFO - Running setup.py (path:/tmp/pip-W6yqIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:32:27 INFO - Running setup.py (path:/tmp/pip-iMtcZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:32:27 INFO - Running setup.py (path:/tmp/pip-5GX9Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:32:27 INFO - Running setup.py (path:/tmp/pip-cl7l_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:32:27 INFO - Running setup.py (path:/tmp/pip-7twDsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:32:27 INFO - Running setup.py (path:/tmp/pip-xzaat9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:32:27 INFO - Running setup.py (path:/tmp/pip-2iXmax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:32:27 INFO - Running setup.py (path:/tmp/pip-Y7qUy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:32:27 INFO - Running setup.py (path:/tmp/pip-LLolZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:32:27 INFO - Running setup.py (path:/tmp/pip-lWWlFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:32:27 INFO - Running setup.py (path:/tmp/pip-h2mcg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:32:27 INFO - Running setup.py (path:/tmp/pip-fl9JrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:32:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:32:27 INFO - Running setup.py install for manifestparser 23:32:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Running setup.py install for mozcrash 23:32:28 INFO - Running setup.py install for mozdebug 23:32:28 INFO - Running setup.py install for mozdevice 23:32:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Running setup.py install for mozfile 23:32:28 INFO - Running setup.py install for mozhttpd 23:32:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Running setup.py install for mozinfo 23:32:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Running setup.py install for mozInstall 23:32:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Running setup.py install for mozleak 23:32:28 INFO - Running setup.py install for mozlog 23:32:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Running setup.py install for moznetwork 23:32:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for mozprocess 23:32:29 INFO - Running setup.py install for mozprofile 23:32:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for mozrunner 23:32:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for mozscreenshot 23:32:29 INFO - Running setup.py install for moztest 23:32:29 INFO - Running setup.py install for mozversion 23:32:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:32:29 INFO - Cleaning up... 23:32:29 INFO - Return code: 0 23:32:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:29 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 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:29 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 23:32:29 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 23:32:29 INFO - Using env: {'DISPLAY': ':0', 23:32:29 INFO - 'HOME': '/home/cltbld', 23:32:29 INFO - 'LANG': 'en_US.UTF-8', 23:32:29 INFO - 'LANGUAGE': 'en_US:en', 23:32:29 INFO - 'LOGNAME': 'cltbld', 23:32:29 INFO - 'MAIL': '/var/mail/cltbld', 23:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:29 INFO - 'MOZ_NO_REMOTE': '1', 23:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:29 INFO - 'NO_EM_RESTART': '1', 23:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:29 INFO - 'PWD': '/builds/slave/test', 23:32:29 INFO - 'SHELL': '/bin/bash', 23:32:29 INFO - 'SHLVL': '1', 23:32:29 INFO - 'TERM': 'linux', 23:32:29 INFO - 'TMOUT': '86400', 23:32:29 INFO - 'USER': 'cltbld', 23:32:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:29 INFO - '_': '/tools/buildbot/bin/python'} 23:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:32:29 INFO - Running setup.py (path:/tmp/pip-KGT8gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:32:30 INFO - Running setup.py (path:/tmp/pip-MNsIVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:32:30 INFO - Running setup.py (path:/tmp/pip-rm0wqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:32:30 INFO - Running setup.py (path:/tmp/pip-CapHzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:32:30 INFO - Running setup.py (path:/tmp/pip-_mEiYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:32:30 INFO - Running setup.py (path:/tmp/pip-1sOEm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:32:30 INFO - Running setup.py (path:/tmp/pip-8vccVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:32:30 INFO - Running setup.py (path:/tmp/pip-xhai71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:32:30 INFO - Running setup.py (path:/tmp/pip-aMtGZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:32:30 INFO - Running setup.py (path:/tmp/pip-e04T7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:32:30 INFO - Running setup.py (path:/tmp/pip-m9DEZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:32:30 INFO - Running setup.py (path:/tmp/pip-JowRhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:32:30 INFO - Running setup.py (path:/tmp/pip-PSSR0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:32:30 INFO - Running setup.py (path:/tmp/pip-fgZSJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:32:30 INFO - Running setup.py (path:/tmp/pip-gGrClB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:32:31 INFO - Running setup.py (path:/tmp/pip-dR5Y8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:32:31 INFO - Running setup.py (path:/tmp/pip-Khy9rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:32:31 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)) 23:32:31 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)) 23:32:31 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)) 23:32:31 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)) 23:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:32:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:32: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 23:32: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 23:32: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 23:32: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 23:32: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 23:32: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 23:32:33 INFO - Downloading blessings-1.6.tar.gz 23:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:32:33 INFO - Installing collected packages: blessings 23:32:33 INFO - Running setup.py install for blessings 23:32:33 INFO - Successfully installed blessings 23:32:33 INFO - Cleaning up... 23:32:33 INFO - Return code: 0 23:32:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:32:33 INFO - Reading from file tmpfile_stdout 23:32:33 INFO - Current package versions: 23:32:33 INFO - argparse == 1.2.1 23:32:33 INFO - blessings == 1.6 23:32:33 INFO - blobuploader == 1.2.4 23:32:33 INFO - docopt == 0.6.1 23:32:33 INFO - functools32 == 3.2.3-2 23:32:33 INFO - jsonschema == 2.5.1 23:32:33 INFO - manifestparser == 1.1 23:32:33 INFO - mozInstall == 1.12 23:32:33 INFO - mozcrash == 1.0 23:32:33 INFO - mozdebug == 0.1 23:32:33 INFO - mozdevice == 0.48 23:32:33 INFO - mozfile == 1.2 23:32:33 INFO - mozhttpd == 0.7 23:32:33 INFO - mozinfo == 0.9 23:32:33 INFO - mozleak == 0.1 23:32:33 INFO - mozlog == 3.4 23:32:33 INFO - moznetwork == 0.27 23:32:33 INFO - mozprocess == 0.23 23:32:33 INFO - mozprofile == 0.28 23:32:33 INFO - mozrunner == 6.13 23:32:33 INFO - mozscreenshot == 0.1 23:32:33 INFO - mozsystemmonitor == 0.3 23:32:33 INFO - moztest == 0.8 23:32:33 INFO - mozversion == 1.4 23:32:33 INFO - psutil == 3.1.1 23:32:33 INFO - requests == 1.2.3 23:32:33 INFO - wsgiref == 0.1.2 23:32:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:32: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')]} 23:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32: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')]} 23:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:33 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 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:33 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 23:32:33 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 23:32:33 INFO - Using env: {'DISPLAY': ':0', 23:32:33 INFO - 'HOME': '/home/cltbld', 23:32:33 INFO - 'LANG': 'en_US.UTF-8', 23:32:33 INFO - 'LANGUAGE': 'en_US:en', 23:32:33 INFO - 'LOGNAME': 'cltbld', 23:32:33 INFO - 'MAIL': '/var/mail/cltbld', 23:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:33 INFO - 'MOZ_NO_REMOTE': '1', 23:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:33 INFO - 'NO_EM_RESTART': '1', 23:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:33 INFO - 'PWD': '/builds/slave/test', 23:32:33 INFO - 'SHELL': '/bin/bash', 23:32:33 INFO - 'SHLVL': '1', 23:32:33 INFO - 'TERM': 'linux', 23:32:33 INFO - 'TMOUT': '86400', 23:32:33 INFO - 'USER': 'cltbld', 23:32:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:33 INFO - '_': '/tools/buildbot/bin/python'} 23:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:33 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)) 23:32:33 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)) 23:32:33 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)) 23:32:33 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)) 23:32:33 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)) 23:32:33 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)) 23:32:33 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)) 23:32:33 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)) 23:32:33 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)) 23:32:33 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)) 23:32:33 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)) 23:32:33 INFO - Cleaning up... 23:32:33 INFO - Return code: 0 23:32:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:32: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')]} 23:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32: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')]} 23:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:33 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 0x7f90328e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', '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 23:32:33 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 23:32:33 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 23:32:33 INFO - Using env: {'DISPLAY': ':0', 23:32:33 INFO - 'HOME': '/home/cltbld', 23:32:33 INFO - 'LANG': 'en_US.UTF-8', 23:32:33 INFO - 'LANGUAGE': 'en_US:en', 23:32:33 INFO - 'LOGNAME': 'cltbld', 23:32:33 INFO - 'MAIL': '/var/mail/cltbld', 23:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:33 INFO - 'MOZ_NO_REMOTE': '1', 23:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:33 INFO - 'NO_EM_RESTART': '1', 23:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:33 INFO - 'PWD': '/builds/slave/test', 23:32:33 INFO - 'SHELL': '/bin/bash', 23:32:33 INFO - 'SHLVL': '1', 23:32:33 INFO - 'TERM': 'linux', 23:32:33 INFO - 'TMOUT': '86400', 23:32:33 INFO - 'USER': 'cltbld', 23:32:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:33 INFO - '_': '/tools/buildbot/bin/python'} 23:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:32:34 INFO - Cleaning up... 23:32:34 INFO - Return code: 0 23:32:34 INFO - Running post-action listener: _resource_record_post_action 23:32:34 INFO - Running post-action listener: _start_resource_monitoring 23:32:34 INFO - Starting resource monitoring. 23:32:34 INFO - [mozharness: 2017-01-24 07:32:34.178816Z] Finished create-virtualenv step (success) 23:32:34 INFO - [mozharness: 2017-01-24 07:32:34.179316Z] Running install step. 23:32:34 INFO - Running pre-action listener: _resource_record_pre_action 23:32:34 INFO - Running main action method: install 23:32:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:32:34 INFO - Reading from file tmpfile_stdout 23:32:34 INFO - Detecting whether we're running mozinstall >=1.0... 23:32:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:32:34 INFO - Reading from file tmpfile_stdout 23:32:34 INFO - Output received: 23:32:34 INFO - Usage: mozinstall [options] installer 23:32:34 INFO - Options: 23:32:34 INFO - -h, --help show this help message and exit 23:32:34 INFO - -d DEST, --destination=DEST 23:32:34 INFO - Directory to install application into. [default: 23:32:34 INFO - "/builds/slave/test"] 23:32:34 INFO - --app=APP Application being installed. [default: firefox] 23:32:34 INFO - mkdir: /builds/slave/test/build/application 23:32:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:32:48 INFO - Reading from file tmpfile_stdout 23:32:48 INFO - Output received: 23:32:48 INFO - /builds/slave/test/build/application/firefox/firefox 23:32:48 INFO - Running post-action listener: _resource_record_post_action 23:32:48 INFO - [mozharness: 2017-01-24 07:32:48.603635Z] Finished install step (success) 23:32:48 INFO - [mozharness: 2017-01-24 07:32:48.603878Z] Running run-tests step. 23:32:48 INFO - Running pre-action listener: _resource_record_pre_action 23:32:48 INFO - Running main action method: run_tests 23:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:32:48 INFO - Python 2.7.3 23:32:48 INFO - Return code: 0 23:32:48 INFO - grabbing minidump binary from tooltool 23:32:48 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')]} 23:32:48 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 0x2948f60>, '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 0x2949d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:32:48 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 23:32:48 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 23:32:48 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 23:32:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:32:48 INFO - Return code: 0 23:32:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:32:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:32:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:32:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:32:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:32:48 INFO - Using env: {'DISPLAY': ':0', 23:32:48 INFO - 'HOME': '/home/cltbld', 23:32:48 INFO - 'LANG': 'en_US.UTF-8', 23:32:48 INFO - 'LANGUAGE': 'en_US:en', 23:32:48 INFO - 'LOGNAME': 'cltbld', 23:32:48 INFO - 'MAIL': '/var/mail/cltbld', 23:32:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:32:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:48 INFO - 'MOZ_NO_REMOTE': '1', 23:32:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:48 INFO - 'NO_EM_RESTART': '1', 23:32:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:48 INFO - 'PWD': '/builds/slave/test', 23:32:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:32:48 INFO - 'SHELL': '/bin/bash', 23:32:48 INFO - 'SHLVL': '1', 23:32:48 INFO - 'TERM': 'linux', 23:32:48 INFO - 'TMOUT': '86400', 23:32:48 INFO - 'USER': 'cltbld', 23:32:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917', 23:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:48 INFO - '_': '/tools/buildbot/bin/python'} 23:32:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:32:48 INFO - mozversion application_buildid: 20170123213845 23:32:48 INFO - mozversion application_changeset: 7443e9844412b8645aafbc9654a6da7adc65cb30 23:32:48 INFO - mozversion application_display_name: Firefox 23:32:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:32:48 INFO - mozversion application_name: Firefox 23:32:48 INFO - mozversion application_remotingname: firefox 23:32:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:32:48 INFO - mozversion application_vendor: Mozilla 23:32:48 INFO - mozversion application_version: 52.0 23:32:48 INFO - mozversion platform_buildid: 20170123213845 23:32:48 INFO - mozversion platform_changeset: 7443e9844412b8645aafbc9654a6da7adc65cb30 23:32:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:32:48 INFO - mozversion platform_version: 52.0 23:32:48 INFO - using testdate: 1485243168 23:32:48 INFO - actual date: 1485243168 23:32:48 INFO - starting webserver on 'localhost:32846' 23:32:48 INFO - SUITE-START | Running 2 tests 23:32:48 INFO - TEST-START | dromaeo_css 23:32:48 INFO - operating with platform_type : linux_ 23:32:48 INFO - Initialising browser for dromaeo_css test... 23:32:48 INFO - TEST-INFO | started process 22505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNAy1J/profile http://localhost:32846/getInfo.html) 23:32:53 INFO - PROCESS | 22505 | __metrics Screen width/height:1600/1200 23:32:53 INFO - PROCESS | 22505 | colorDepth:24 23:32:53 INFO - PROCESS | 22505 | Browser inner width/height: 1024/697 23:32:53 INFO - PROCESS | 22505 | __metrics 23:32:53 ERROR - PROCESS | 22505 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 23:32:54 INFO - TEST-INFO | 22505: exit 0 23:32:54 INFO - Browser initialized. 23:32:54 INFO - Running cycle 1/1 for dromaeo_css test... 23:32:54 INFO - TEST-INFO | started process 22637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNAy1J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:33:06 INFO - PROCESS | 22637 | RSS: Main: 149368832 23:33:06 INFO - PROCESS | 22637 | 23:36:06 INFO - PROCESS | 22637 | Cycle 1(1): loaded http://localhost:32846/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32846/tests/dromaeo/cssquery-ext.html) 23:36:07 INFO - PROCESS | 22637 | RSS: Main: 155131904 23:36:07 INFO - PROCESS | 22637 | 23:39:09 INFO - PROCESS | 22637 | Cycle 1(1): loaded http://localhost:32846/tests/dromaeo/cssquery-ext.html (next: http://localhost:32846/tests/dromaeo/cssquery-jquery.html) 23:39:09 INFO - PROCESS | 22637 | RSS: Main: 152645632 23:39:09 INFO - PROCESS | 22637 | 23:42:11 INFO - PROCESS | 22637 | Cycle 1(1): loaded http://localhost:32846/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32846/tests/dromaeo/cssquery-mootools.html) 23:42:12 INFO - PROCESS | 22637 | RSS: Main: 151601152 23:42:12 INFO - PROCESS | 22637 | 23:45:13 INFO - PROCESS | 22637 | Cycle 1(1): loaded http://localhost:32846/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32846/tests/dromaeo/cssquery-prototype.html) 23:45:14 INFO - PROCESS | 22637 | RSS: Main: 153919488 23:45:14 INFO - PROCESS | 22637 | 23:48:17 INFO - PROCESS | 22637 | Cycle 1(1): loaded http://localhost:32846/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32846/tests/dromaeo/cssquery-yui.html) 23:48:17 INFO - PROCESS | 22637 | RSS: Main: 155508736 23:48:17 INFO - PROCESS | 22637 | 23:51:19 INFO - PROCESS | 22637 | Cycle 1(1): loaded http://localhost:32846/tests/dromaeo/cssquery-yui.html (next: http://localhost:32846/tests/dromaeo/cssquery-dojo.html) 23:51:20 INFO - PROCESS | 22637 | RSS: Main: 154939392 23:51:20 INFO - PROCESS | 22637 | 23:51:20 INFO - PROCESS | 22637 | __start_tp_report 23:51:20 INFO - PROCESS | 22637 | _x_x_mozilla_page_load 23:51:20 INFO - PROCESS | 22637 | _x_x_mozilla_page_load_details 23:51:20 INFO - PROCESS | 22637 | |i|pagename|runs| 23:51:20 INFO - PROCESS | 22637 | |0;dojo.html;3253.934921301574;3278.9508157377645;3285.6385797562266;3302.867885284588;3312.2547426828983;5679.574031947605;5723.627964182325;5738;5748.511376532989;5752.597318187723;5667.234923285355;5681.7727290908415;5747.42525747425;5749.540036797046;5758;5165.974170129163;5205.531502164805;5222.216667499867;5250.081235783722;5271.472852714736;5261.368635763694;5264.92102618461;5277.12927366984;5282.128448805943;5288.973555132238;5106.897862042757;5127.538521533062;5255.921161182585;5258.1849813279005;5292.047431462335;5080.1617733074;5108.897822043576;5140.331756871583;5217.373915130209;5230.947690523103;5054.620903432257;5139.434662187156;5146.0479811235045;5151.150060240056;5154.278401023822;5567.248421463131;5585.944140558624;5657.547396208334;5678.14827775837;5706.629069110494;5947.613405128696;5950.672713000783;5979.790707325223;6000.609960352563;6018.729157187893;6001.819945401601;6040.395960403968;6048.485878700316;6050.27396712393;6055.788047418363;5676.517496012802;5681.602287839812;5682.971585142089;5691.459311365414;5702.258706368146;6062;6094.360092190344;6129.693515324216;6131.434797534288;6171.197744293213;5865.853353666107;5913.7876735269165;5923;5940.821775346746;5948.970255148696;6055.091736239511;6066.605670631395;6068.817935461943;6069.302030266487;6089.8477538061015;5892.292924849045;5929.169916211734;5945.316288626863;5961.4038596140035;5969.970150149308;5953.107033944856;5998.310194327708;6006.069059295816;6029.758809647565;6039.335673075958;4622.67641265115;4624.098300831373;4655.44134703831;4655.557722016403;4698.271767875985;4023.879283621496;4067.28822456069;4091.6112969267874;4102.815373308208;4146.543880173179;5655.971720141455;5686.2039314496005;5703.116017017369;5713.200151978726;5734.16854556087;5981.700914954235;6037.728302226323;6041.184440100618;6047.8488037798525;6058.787942421994;5600.663960162403;5633;5694.402087780806;5696.23100881384;5697.572682048863;5130.717810520383;5143.048536020773;5169.534741873174;5174.0169367820745;5176.378834539879;6252.155958945576;6319.494440444753;6320.968395158086;6322.9051564226575;6338.968305158444;5969.313528944227;6046.697665116814;6095.695215239309;6097.756089756537;6120.3267640558615;6248.937510624835;6377.202849643794;6382.36176382358;6386.584871983307;6393.1369265148605;6007.789727359522;6016.909746353896;6017.247844019497;6028.668423236764;6040.818775436744;5922.141289512911;5991.520678345809;6075.574709770451;6140.232470941132;6162.815115546541;6003.969980150071;6016;6025.638461692312;6103.7558497661375;6128.142060111499;6016.578839481194;6047.606905551125;6056.818295451144;6058.5153187745755;6092.360302168386;5684.403137670485;6034.185384972972;6036.33600303975;6041.818745437468;6042.546808989431;5833.125031245348;5898.64608123514;5911.970440147944;5951.553633477593;6023.759049638141;5805.854853628524;5814.476697097281;5816.883662326814;5817.331006934257;5828.213191219131 23:51:20 INFO - PROCESS | 22637 | |1;ext.html;585.8476796033033;624.282075613045;640.4172203295002;664.6942406493016;672.4015626092776;46623.76688116563;48024.519754802444;48142.277865831995;50510;50983;47425.52574474263;47781.28328075082;47908;47917.76041119798;47965.760171199094;8876.378653494274;9019.143181397789;9027.503487308195;9027.864582031241;9029.413088149282;8926.821463570725;9004.77488062797;9019.45883247004;9030.819383612325;9035.909640903605;9044.276457883354;9093.681721139761;9135.269178465707;9135.36052476327;9142.542872856364;8952.373333866632;9015.864762028576;9019.59411826466;9031.593578288926;9037.18665320121;8902.376833621649;8980.371374003822;8983.68557100505;8998.55007249635;9007.054259302744;43610.781946090065;43826;43912.12175756467;43929.56070439287;44070.77964610157;3438.209211881281;3950.249452603996;4217.903345130258;4304.7632380219075;4327.437433133704;33828;33846;34015.31969360624;34050.829745851115;34063.829680851435;3848.9037774055873;3849.3263678856088;3858.9807050964564;3922.666573341241;3982.6216509431556;333022;333366;334733;334906;335705;63136.368636313964;63706.681466592374;63718.681406592674;63930.6803465989;64113.67943160254;65954;66035.33964660388;66097.66951165213;66171;66185.6690716553;17537.123143842757;17781.555461113316;17806.109694515224;17912.193951272224;18071.638567228583;13242.20546767197;13325.000624953167;13347.866521334663;13371.064025518315;13428.127171734002;18582.070896455123;19413.462637182598;19574.230027672154;19664.901675491532;19810.801891980896;6794.874357795371;6976.965115174493;7046.92953070473;7066.823329416806;7114.608696521741;985.3742873275521;1058.85705429766;1078.2021304234809;1102.8199826186064;1132.394169119517;32717.836410817792;32733.18167045843;32829.67170328314;32967.1758206042;33257.501137482956;1161.8663853656938;1167.3229526874393;1169.1990986174499;1177.0289511153333;1225.7425940552405;17350.91324543369;17419.47741567755;17498.475045748648;17530.211140498708;17634.470965871045;480703;480941;481060;481454;486041;61171.694141529006;61484.692576537724;61668.69165654143;61808.38191618026;61811.690941545006;1436.289036926707;1436.5115860607443;1441.7909403136696;1453.4549543921241;1468.3979568377129;30337.544936825525;31845.5223171648;32033.199170020936;32306.19234519062;33276.16809579683;54742.45257547533;54986;55385.1692224625;55402.72298638481;55507.722461387435;339358;341420;341555;341650;342433;44181.77909110434;44818.77590612026;44863.10273794571;45338;45425.545744542134;50757.238641419666;51317;51571.484285156665;51870.22194667008;52244;42683.786581066895;43155;44137.77931110324;44806.55193448024;45295.320570190815;41708.79145604374;42098.57901420946;42775.57224427716;44007;44167.33748993832;42628.360574590784;42912.78543607262;42963.570364295956;43203;44263;37671.81164094162;38752;38955;39425.60574394219;39493.80253098716;28974;29321.56017659694;29782.25544361408;29830.25424364408;30123.246918827204 23:51:20 INFO - PROCESS | 22637 | |2;jquery.html;411.83114922881606;415.2960731560007;425.4214268594711;432.61281153367736;446.54898552462004;18942.24231030759;20177.596448071028;20451.897740511296;20938;21092.894535527303;19694.606107877833;19855;20051.699224511645;20489.692654610193;20502.589948201028;5717.59976801623;6007.519398448114;6010.429009244137;6011.098335249704;6012.068129439922;5781.248437703114;5903.970480147594;5996.220491336142;6060.848478788022;6092.847678808043;6153.35389784073;6170.136180934673;6171.413715697024;6177.25872895251;6178.10417489466;6056.364081771417;6564.376384243489;6612.14042174519;6616.239132499776;6634.3365663433515;5830.62100963436;5903.409659034062;5941.168236446858;5945.078512830518;6053.939460605382;14948.47680331194;15184.46854360092;15244.618884527865;15268.923655381652;23752.04991800326;2363.3028256664325;2366.183666635008;2417.867017314047;2498.5877330240487;2512.773850353477;10829.729256768565;11050.33697978124;11157.218994670377;13497.055206135574;14390.568282951528;1989.9403017909485;2002.6495363311508;2012.597480503905;2042.4791678122133;2082.8125468707735;83121.58439207765;84252.57873710593;85693.57153214194;85761;86499.56750216271;11690.181687281978;11745.765084698258;11758.588969323735;11956.282623042645;12023.398830058462;16886.493405197863;16891.577710557336;16940.40708575194;16974.32102715902;17015.319387224372;8318.37612179089;8503.319734421231;8519.872201916976;8572.52851093196;8627;7896.32881205104;8138.674453021813;8145.959270203611;8203.58982050907;8233.053198882206;5041.269015992661;5057.039162559102;5061.240813877947;5101.183810590288;5123.2827404163445;2095.968560471594;2097.7902209779204;2105;2136.8717876927435;2154.784521547833;970.5486948568808;1066.248294952057;1073.8067147913293;1102.3165637304921;1139.1399493382444;19325.51686207856;19722.408327750192;21379.572408551743;21530.24644137479;21838.23566175208;1031.7626945802358;1050.873895132589;1051.8737751469873;1058.751193469534;1072.7961687279392;10858;11200.775984480264;11259.831102533468;11262.267952583219;11262.774744505065;439721;445521;448597;448705;478273;87557.56221218852;93711.53144234371;95935;97266.51366743121;97906;1055.2454994678687;1064.3135177810425;1064.3932958213898;1090.2204923479592;1110.6723516562633;17466.73799893028;17586.120693964996;17869.821301786815;17891.910540447214;18258;42364.576354236066;42663.20493296978;43181.784091079346;43609.781951090044;44251;54966.450335497735;57865.710671448054;58833.70583147228;59601.40398595959;64775.02837457536;8873.822523549621;8928.73213803587;9144.451332920045;9180.173784359173;9295.76760580991;9910.702678919644;12933.159344642569;13327.067105302536;13445.193288402726;13702.65743356424;11778.882211177779;11925;12001.279923204636;12170.269783812999;12193.146479746332;10637;10936.179786515884;11101.944490277498;11570.537178512765;11741;11455.427228638368;11472.196946213686;11709.238899471507;11719.589814356457;11729.530818767495;8322.568095326082;8389.706360277361;8510.91489085126;8567.914320856711;8874.866876996979;10779.51492182838;11294;11469.827952580552;11709.297442153498;11823.586174483851 23:51:20 INFO - PROCESS | 22637 | |3;mootools.html;1478.2830327291263;1513.2509407843115;1692.4076573199382;1796.5418818201356;1853.82388673076;8147.91852081479;8717.694880679177;8765.211130998217;8865.645374185026;9197;8792.560371981408;8826.955865220682;8948.105189481064;8960.731178064652;8973;2494.825362224645;2497.288272842245;2516.2954372775653;2525.053105085593;2528.254165021323;2340.3447034830274;2375.714914210297;2400.8319417640773;2402.4714562796157;2407.061246114008;2420.987895060531;2426.259990702835;2451.2646206138174;2459.29909975657;2468.049800826677;2376.275236053003;2393.8922748476275;2407.253751337091;2416;2425.987870060656;2302.34383200787;2303.8963246653775;2308.7344955330186;2310.861348319106;2320.153144102407;8688.08775078614;8840.646374145026;8876.689315873979;8907.153820387053;8914.955425222897;5347.385050719178;5409.540189083933;5424.484673955968;5432.70120143392;5456.208849716809;3418.66671997921;3470.392681280791;3551.6448355164275;3559.341521818472;3582.695470884978;1044.4099084017582;1052.6263176572284;1060.173065009294;1076.39183861119;1093.0272057868503;12223.14437989341;12267.141300108997;12315.384230788515;12337.69155771104;12379.381030948507;4423.447069116361;4601.861944141681;4669.883252918704;4690.882727931761;4692.319613656001;9839.704808855746;9878.456684882256;9878.901210987799;9879.160271377013;9885.703428897144;5387.892242155213;5387.9461205388225;5392.703401312887;5420.24116623673;5426.430224826337;4850.102730994778;4978.975105124524;5100.566451851634;5177.844664660066;5204.661696989683;3668.211334563082;3736.252749450121;3762.6049264827348;3803.0112170835782;3821.407681809324;1141.19545720267;1146.5643055638805;1151.407025381929;1160.1125139268465;1166.0205427440821;972.1105188752213;972.1445128287204;972.9367591106698;983.7442265011149;1000.364768372089;5823.56323275756;5909.970450147808;5951.642901425842;6031.366706495843;6035.275766907999;446.894979679775;452.0890405832251;454.7476150736373;457.42364620577644;460.4037771086451;4156.106437116035;4251.829926802893;4267.786610669454;4275.080857615628;4312;10240.846387304196;10477.37135771856;10535;10617.362958222377;10617.416042117604;10415.375077495375;10515.631952881766;10528.684139475828;10865.619703310345;10871.83692244617;8372.58137093143;8547.316214702809;8556.144385561518;8574.928133983252;8575.95712021436;5942.346341902474;5967.134765459071;6016;6025.18659980897;6293.496520278275;10179.440130792878;10209.74475638115;10265.230107742098;10395.064444200058;10415.166786656897;10245.129164020844;10249.48752562354;10629.787404251718;10645.201609879136;10682.89317106819;7674.61626918663;7782.805429864298;7898.091719452336;7910.52536847791;7931.405144614292;8727.607257673548;8736.99524554659;8791.692290770048;8795.868061979203;8806.339524535557;7743.264389882952;7773.067231932205;7843.764687059397;7866.960665196638;7872.409569282212;7317.8902316466365;7380.557166570023;7422.517536360119;7809.33620642229;7817.296443320129;6910.170779506491;6933.7226510939;6954.061201737701;6955.1653801544135;7145.606991615511;5083.72039537829;5223.686578805284;5276.894462110813;5287.920681189862;5311.203319502106;5153.4073581538605;5165.147750621106;5178.533931946143;5195.090859099567;5242.5281724644965 23:51:20 INFO - PROCESS | 22637 | |4;prototype.html;339.79272643687347;358.6933172137822;359.50747475957934;363.7053986271119;367.67277123360213;5578.525825304854;5628.77484900604;5680.801171958982;5693.601447898649;5708.457696518834;5576.20817843866;5609.467100625444;5618.325800903887;5621.8594535136535;5659.462351076651;4421.624161946223;4422.270325396305;4425.941936999295;4428.778561071934;4448.177087238855;4264.55222201669;4412.77155036706;4416.246190737863;4421.469423669164;4436.312371582394;4376.1247750449875;4376.6869939018325;4384.903774056486;4385.368778732751;4390.517043125254;4381.9342709859375;4385.802638881258;4393.846215382462;4397.120575884804;4399.5160532341415;3731.9440208396895;3880.9521429213955;3894.1627550076587;3903.2193561287854;3908.218356328717;5399.433059528732;5432.185172224198;5437.32033495813;5440.537554307889;5461.15352120422;4994.7013776418025;4998.250262460624;5003.4746351633285;5007.399112106534;5020.974895125501;5623.718814059281;5799.681017544033;5802.970985145047;5834.912476312858;5855.619384739978;4259.936100958488;4263.722858014219;4265.637420819234;4267.978660106711;4271.722338048017;6003.609765365237;6065.211522502091;6069.969650151721;6096;6096.969515152396;4229.323308270662;4286.442762440863;4312.159128969884;4347.065380943112;4357.43353364067;4401.657494464155;4404.493483249404;4404.515503294635;4404.55954404557;4408.515063343029;5009.949900500948;5013.298138260647;5017.294119999145;5019.648624596243;5033.723145226974;5781.5952883298605;5885.558583106199;5903.645781253139;5908.645481271137;5929.258842644669;1490.4336352186099;1504.9916555907569;1508.6077619818707;1516.7638374724784;1518.1933499135994;1023.9283250172565;1061.0715623829149;1072.8766191887876;1075.5267682219956;1080.206048554312;5385.9730701347025;5447.373552041487;5460.672359658433;5462.726863656881;5502.367227768777;5847.912281315784;5863.3257175424515;5864;5880.500157486662;5887.587868849225;5309;5385;5395.649282796684;5472.753726082336;5476.808311709071;3077.2153100959113;3116.3299890523645;3134.1067795678123;3138.952915706266;3145.716885480272;5975.207437768652;6064.4541991221;6075.301340345828;6078.787242446493;6100.620757904421;6151.9384806151365;6204.5967012144065;6206.906896396557;6217.751289948442;6223.719932603044;6216.968915155395;6343.302236753953;6352.904706429407;6358.936410635927;6375.808725738235;5961.4038596140035;6071.482129467633;6077.450250186174;6087.66517841523;6127;5979.727703472652;6015.157877897011;6025.758969641165;6032.54755893301;6055.091736239599;6140.263168419639;6294.402031806971;6340.9048864268;6349.523785715997;6352;4193.937090943699;4232.365145228117;4235.703500755041;4245.936310955276;4254.234237837219;5911.645301281765;6086.878262434815;6117.785877494266;6117.941029485258;6121.449069583581;5898.233229680114;5931.169636251015;5972.297175751062;5974.253218347707;5981;5906.320773111147;5906.468417842415;5916.171735957056;5919.911201331897;5938.257717785277;5716.857078573069;5873.530117590668;5881.617694849821;5919;5930.466258036798;5948;5961;5967.181004157256;5967.761289548543;5975.611585246945;5683.403242659461;5779.682117483579;5792.884142317214;5796.59423840344;5820.417958204146 23:51:20 INFO - PROCESS | 22637 | |5;yui.html;747.7046566606191;774.639792496489;789.403999980015;817.9672813087477;861.7457849934269;14206.502772402968;14508.274586270698;14541.709165816677;14566.854331456681;14596.635084122901;14307.57077287683;15256.466023689145;15772.211389430511;15836.683266334667;16269.186540672978;679.6329981809816;699.8600279944006;703.5040296590892;840.1346612988616;848.4315508609246;828.1842385250553;828.4615000249855;831.6382373667444;839.1147339556766;840.504102579478;887.5029983209423;888.8622263549161;889.0798024045115;889.4352086425134;889.4974339498195;874.8993865705462;881.5504092912629;882.5675419044686;883.6509578716403;886.6940905387631;655.115593948171;655.9147310849606;657.2540166910543;657.9572327798726;659.7789740436959;15394.692106157927;15506.9224653876;15537.533873983799;15547.92226038874;16094.436694715629;14394.352254148589;14713.779293310608;15114.168720720356;15178.924105379512;15308.770368444371;11900.940495297467;12018.218815776947;12026.699332516757;12057.93971030148;12185.086118541145;3900.7659540427667;3933.115049113955;3944.467496887912;3966.880993570169;4005.419214213952;67640.6617966907;69444.6527767363;70044.6497767513;70943.64528177377;71443.28556714418;10555;10669.413182274895;10687.412192329497;10714.678559643224;11074.889251107546;20668.793312066686;20770.273040443513;20854.687179692315;20941.371758847257;21163.365099047052;8142.3486121111355;8206.630701618442;8323.167683231628;8333;8458.703945362005;4327.112941846914;4443.37792709021;4495.325701144789;4535.274356103074;4599.724016559017;3468.601110872282;3594.8202589870402;3596.28074385124;3604.4773507841214;3608.747387682837;592.8340064781868;662.3376623376623;688.5386790850142;690.147667630476;695.7738734911175;612;700.1598082301157;748.2442732839871;788.787027502571;796.2037962037962;9339.533023348806;9933.950330248303;10049.346792458467;10092;10159.390436573829;688.9621070841051;741.6069483173926;765.9923400765921;776.4332037612462;776.9300762931364;4807.399075115611;4809;4879.26810978349;4891.828785992473;5026.095302845523;72191.2780872195;75571.62214188893;88848;90843;91627;44945.325820112725;56686;67278;71114;72529.27470725331;65677;68587.65706171437;69553.3044669557;69928.6503567479;70570.2942970574;9906.851397229191;9964.750881228027;10435.843462347919;10611.469426528796;10624.20318476102;45587.31619025651;46000.539994599625;46603.30095048509;46996.06007879755;47253.52746472491;56396.43603563912;57443;61592.69203653953;61739.38260617336;62529.68735156295;13060;13081.215127092404;13114;13231.603051908458;13350.465981360638;14363.450460111142;14564.927175364055;14760.114393136446;14812.333444995216;14848.480303189337;13380.598582042554;13703.862961370258;13742.65643358924;13872.583822485341;14014;13386.598402047954;13871.583852484442;13916.721665566429;13986.16083035021;14327.641808954859;13135;13225;13315.400806963517;13387.129836560593;13726.382312796148;10814.621488248189;10884.782304354027;11150.163737719866;11266.324020558794;11302.378369189773;11688;11718.765624687629;11761.117916156152;11869.347185904859;12076.51693932233 23:51:20 INFO - PROCESS | 22637 | __end_tp_report 23:51:20 INFO - PROCESS | 22637 | __start_cc_report 23:51:20 INFO - PROCESS | 22637 | _x_x_mozilla_cycle_collect,300 23:51:20 INFO - PROCESS | 22637 | __end_cc_report 23:51:20 INFO - PROCESS | 22637 | __startTimestamp1485244280228__endTimestamp 23:51:20 INFO - PROCESS | 22637 | 23:51:20 INFO - PROCESS | 22637 | ------- Summary: start ------- 23:51:20 INFO - PROCESS | 22637 | Number of tests: 6 23:51:20 INFO - PROCESS | 22637 | 23:51:20 INFO - PROCESS | 22637 | [#0] dojo.html Cycles:165 Average:5637.84 Median:5865.85 stddev:639.56 (10.9%) stddev-sans-first:613.57 23:51:20 INFO - PROCESS | 22637 | Values: 3253.9 3279.0 3285.6 3302.9 3312.3 5679.6 5723.6 5738.0 5748.5 5752.6 5667.2 5681.8 5747.4 5749.5 5758.0 5166.0 5205.5 5222.2 5250.1 5271.5 5261.4 5264.9 5277.1 5282.1 5289.0 5106.9 5127.5 5255.9 5258.2 5292.0 5080.2 5108.9 5140.3 5217.4 5230.9 5054.6 5139.4 5146.0 5151.2 5154.3 5567.2 5585.9 5657.5 5678.1 5706.6 5947.6 5950.7 5979.8 6000.6 6018.7 6001.8 6040.4 6048.5 6050.3 6055.8 5676.5 5681.6 5683.0 5691.5 5702.3 6062.0 6094.4 6129.7 6131.4 6171.2 5865.9 5913.8 5923.0 5940.8 5949.0 6055.1 6066.6 6068.8 6069.3 6089.8 5892.3 5929.2 5945.3 5961.4 5970.0 5953.1 5998.3 6006.1 6029.8 6039.3 4622.7 4624.1 4655.4 4655.6 4698.3 4023.9 4067.3 4091.6 4102.8 4146.5 5656.0 5686.2 5703.1 5713.2 5734.2 5981.7 6037.7 6041.2 6047.8 6058.8 5600.7 5633.0 5694.4 5696.2 5697.6 5130.7 5143.0 5169.5 5174.0 5176.4 6252.2 6319.5 6321.0 6322.9 6339.0 5969.3 6046.7 6095.7 6097.8 6120.3 6248.9 6377.2 6382.4 6386.6 6393.1 6007.8 6016.9 6017.2 6028.7 6040.8 5922.1 5991.5 6075.6 6140.2 6162.8 6004.0 6016.0 6025.6 6103.8 6128.1 6016.6 6047.6 6056.8 6058.5 6092.4 5684.4 6034.2 6036.3 6041.8 6042.5 5833.1 5898.6 5912.0 5951.6 6023.8 5805.9 5814.5 5816.9 5817.3 5828.2 23:51:20 INFO - PROCESS | 22637 | 23:51:20 INFO - PROCESS | 22637 | [#1] ext.html Cycles:180 Average:57532.18 Median:43920.84 stddev:103159.99 (234.9%) stddev-sans-first:103360.77 23:51:20 INFO - PROCESS | 22637 | Values: 585.8 624.3 640.4 664.7 672.4 46623.8 48024.5 48142.3 50510.0 50983.0 47425.5 47781.3 47908.0 47917.8 47965.8 8876.4 9019.1 9027.5 9027.9 9029.4 8926.8 9004.8 9019.5 9030.8 9035.9 9044.3 9093.7 9135.3 9135.4 9142.5 8952.4 9015.9 9019.6 9031.6 9037.2 8902.4 8980.4 8983.7 8998.6 9007.1 43610.8 43826.0 43912.1 43929.6 44070.8 3438.2 3950.2 4217.9 4304.8 4327.4 33828.0 33846.0 34015.3 34050.8 34063.8 3848.9 3849.3 3859.0 3922.7 3982.6 333022.0 333366.0 334733.0 334906.0 335705.0 63136.4 63706.7 63718.7 63930.7 64113.7 65954.0 66035.3 66097.7 66171.0 66185.7 17537.1 17781.6 17806.1 17912.2 18071.6 13242.2 13325.0 13347.9 13371.1 13428.1 18582.1 19413.5 19574.2 19664.9 19810.8 6794.9 6977.0 7046.9 7066.8 7114.6 985.4 1058.9 1078.2 1102.8 1132.4 32717.8 32733.2 32829.7 32967.2 33257.5 1161.9 1167.3 1169.2 1177.0 1225.7 17350.9 17419.5 17498.5 17530.2 17634.5 480703.0 480941.0 481060.0 481454.0 486041.0 61171.7 61484.7 61668.7 61808.4 61811.7 1436.3 1436.5 1441.8 1453.5 1468.4 30337.5 31845.5 32033.2 32306.2 33276.2 54742.5 54986.0 55385.2 55402.7 55507.7 339358.0 341420.0 341555.0 341650.0 342433.0 44181.8 44818.8 44863.1 45338.0 45425.5 50757.2 51317.0 51571.5 51870.2 52244.0 42683.8 43155.0 44137.8 44806.6 45295.3 41708.8 42098.6 42775.6 44007.0 44167.3 42628.4 42912.8 42963.6 43203.0 44263.0 37671.8 38752.0 38955.0 39425.6 39493.8 28974.0 29321.6 29782.3 29830.3 30123.2 23:51:20 INFO - PROCESS | 22637 | 23:51:20 INFO - PROCESS | 22637 | [#2] jquery.html Cycles:180 Average:28364.07 Median:11996.51 stddev:74933.88 (624.6%) stddev-sans-first:75114.70 23:51:20 INFO - PROCESS | 22637 | Values: 411.8 415.3 425.4 432.6 446.5 18942.2 20177.6 20451.9 20938.0 21092.9 19694.6 19855.0 20051.7 20489.7 20502.6 5717.6 6007.5 6010.4 6011.1 6012.1 5781.2 5904.0 5996.2 6060.8 6092.8 6153.4 6170.1 6171.4 6177.3 6178.1 6056.4 6564.4 6612.1 6616.2 6634.3 5830.6 5903.4 5941.2 5945.1 6053.9 14948.5 15184.5 15244.6 15268.9 23752.0 2363.3 2366.2 2417.9 2498.6 2512.8 10829.7 11050.3 11157.2 13497.1 14390.6 1989.9 2002.6 2012.6 2042.5 2082.8 83121.6 84252.6 85693.6 85761.0 86499.6 11690.2 11745.8 11758.6 11956.3 12023.4 16886.5 16891.6 16940.4 16974.3 17015.3 8318.4 8503.3 8519.9 8572.5 8627.0 7896.3 8138.7 8146.0 8203.6 8233.1 5041.3 5057.0 5061.2 5101.2 5123.3 2096.0 2097.8 2105.0 2136.9 2154.8 970.5 1066.2 1073.8 1102.3 1139.1 19325.5 19722.4 21379.6 21530.2 21838.2 1031.8 1050.9 1051.9 1058.8 1072.8 10858.0 11200.8 11259.8 11262.3 11262.8 439721.0 445521.0 448597.0 448705.0 478273.0 87557.6 93711.5 95935.0 97266.5 97906.0 1055.2 1064.3 1064.4 1090.2 1110.7 17466.7 17586.1 17869.8 17891.9 18258.0 42364.6 42663.2 43181.8 43609.8 44251.0 54966.5 57865.7 58833.7 59601.4 64775.0 8873.8 8928.7 9144.5 9180.2 9295.8 9910.7 12933.2 13327.1 13445.2 13702.7 11778.9 11925.0 12001.3 12170.3 12193.1 10637.0 10936.2 11101.9 11570.5 11741.0 11455.4 11472.2 11709.2 11719.6 11729.5 8322.6 8389.7 8510.9 8567.9 8874.9 10779.5 11294.0 11469.8 11709.3 11823.6 23:51:20 INFO - PROCESS | 22637 | 23:51:20 INFO - PROCESS | 22637 | [#3] mootools.html Cycles:180 Average:5830.24 Median:4771.21 stddev:3294.50 (69.0%) stddev-sans-first:3287.51 23:51:20 INFO - PROCESS | 22637 | Values: 1478.3 1513.3 1692.4 1796.5 1853.8 8147.9 8717.7 8765.2 8865.6 9197.0 8792.6 8827.0 8948.1 8960.7 8973.0 2494.8 2497.3 2516.3 2525.1 2528.3 2340.3 2375.7 2400.8 2402.5 2407.1 2421.0 2426.3 2451.3 2459.3 2468.0 2376.3 2393.9 2407.3 2416.0 2426.0 2302.3 2303.9 2308.7 2310.9 2320.2 8688.1 8840.6 8876.7 8907.2 8915.0 5347.4 5409.5 5424.5 5432.7 5456.2 3418.7 3470.4 3551.6 3559.3 3582.7 1044.4 1052.6 1060.2 1076.4 1093.0 12223.1 12267.1 12315.4 12337.7 12379.4 4423.4 4601.9 4669.9 4690.9 4692.3 9839.7 9878.5 9878.9 9879.2 9885.7 5387.9 5387.9 5392.7 5420.2 5426.4 4850.1 4979.0 5100.6 5177.8 5204.7 3668.2 3736.3 3762.6 3803.0 3821.4 1141.2 1146.6 1151.4 1160.1 1166.0 972.1 972.1 972.9 983.7 1000.4 5823.6 5910.0 5951.6 6031.4 6035.3 446.9 452.1 454.7 457.4 460.4 4156.1 4251.8 4267.8 4275.1 4312.0 10240.8 10477.4 10535.0 10617.4 10617.4 10415.4 10515.6 10528.7 10865.6 10871.8 8372.6 8547.3 8556.1 8574.9 8576.0 5942.3 5967.1 6016.0 6025.2 6293.5 10179.4 10209.7 10265.2 10395.1 10415.2 10245.1 10249.5 10629.8 10645.2 10682.9 7674.6 7782.8 7898.1 7910.5 7931.4 8727.6 8737.0 8791.7 8795.9 8806.3 7743.3 7773.1 7843.8 7867.0 7872.4 7317.9 7380.6 7422.5 7809.3 7817.3 6910.2 6933.7 6954.1 6955.2 7145.6 5083.7 5223.7 5276.9 5287.9 5311.2 5153.4 5165.1 5178.5 5195.1 5242.5 23:51:20 INFO - PROCESS | 22637 | 23:51:20 INFO - PROCESS | 22637 | [#4] prototype.html Cycles:180 Average:4956.25 Median:5577.37 stddev:1452.07 (26.0%) stddev-sans-first:1414.19 23:51:20 INFO - PROCESS | 22637 | Values: 339.8 358.7 359.5 363.7 367.7 5578.5 5628.8 5680.8 5693.6 5708.5 5576.2 5609.5 5618.3 5621.9 5659.5 4421.6 4422.3 4425.9 4428.8 4448.2 4264.6 4412.8 4416.2 4421.5 4436.3 4376.1 4376.7 4384.9 4385.4 4390.5 4381.9 4385.8 4393.8 4397.1 4399.5 3731.9 3881.0 3894.2 3903.2 3908.2 5399.4 5432.2 5437.3 5440.5 5461.2 4994.7 4998.3 5003.5 5007.4 5021.0 5623.7 5799.7 5803.0 5834.9 5855.6 4259.9 4263.7 4265.6 4268.0 4271.7 6003.6 6065.2 6070.0 6096.0 6097.0 4229.3 4286.4 4312.2 4347.1 4357.4 4401.7 4404.5 4404.5 4404.6 4408.5 5009.9 5013.3 5017.3 5019.6 5033.7 5781.6 5885.6 5903.6 5908.6 5929.3 1490.4 1505.0 1508.6 1516.8 1518.2 1023.9 1061.1 1072.9 1075.5 1080.2 5386.0 5447.4 5460.7 5462.7 5502.4 5847.9 5863.3 5864.0 5880.5 5887.6 5309.0 5385.0 5395.6 5472.8 5476.8 3077.2 3116.3 3134.1 3139.0 3145.7 5975.2 6064.5 6075.3 6078.8 6100.6 6151.9 6204.6 6206.9 6217.8 6223.7 6217.0 6343.3 6352.9 6358.9 6375.8 5961.4 6071.5 6077.5 6087.7 6127.0 5979.7 6015.2 6025.8 6032.5 6055.1 6140.3 6294.4 6340.9 6349.5 6352.0 4193.9 4232.4 4235.7 4245.9 4254.2 5911.6 6086.9 6117.8 6117.9 6121.4 5898.2 5931.2 5972.3 5974.3 5981.0 5906.3 5906.5 5916.2 5919.9 5938.3 5716.9 5873.5 5881.6 5919.0 5930.5 5948.0 5961.0 5967.2 5967.8 5975.6 5683.4 5779.7 5792.9 5796.6 5820.4 23:51:20 INFO - PROCESS | 22637 | 23:51:20 INFO - PROCESS | 22637 | [#5] yui.html Cycles:180 Average:17772.65 Median:25061.30 stddev:22614.20 (90.2%) stddev-sans-first:22641.50 23:51:20 INFO - PROCESS | 22637 | Values: 747.7 774.6 789.4 818.0 861.7 14206.5 14508.3 14541.7 14566.9 14596.6 14307.6 15256.5 15772.2 15836.7 16269.2 679.6 699.9 703.5 840.1 848.4 828.2 828.5 831.6 839.1 840.5 887.5 888.9 889.1 889.4 889.5 874.9 881.6 882.6 883.7 886.7 655.1 655.9 657.3 658.0 659.8 15394.7 15506.9 15537.5 15547.9 16094.4 14394.4 14713.8 15114.2 15178.9 15308.8 11900.9 12018.2 12026.7 12057.9 12185.1 3900.8 3933.1 3944.5 3966.9 4005.4 67640.7 69444.7 70044.6 70943.6 71443.3 10555.0 10669.4 10687.4 10714.7 11074.9 20668.8 20770.3 20854.7 20941.4 21163.4 8142.3 8206.6 8323.2 8333.0 8458.7 4327.1 4443.4 4495.3 4535.3 4599.7 3468.6 3594.8 3596.3 3604.5 3608.7 592.8 662.3 688.5 690.1 695.8 612.0 700.2 748.2 788.8 796.2 9339.5 9934.0 10049.3 10092.0 10159.4 689.0 741.6 766.0 776.4 776.9 4807.4 4809.0 4879.3 4891.8 5026.1 72191.3 75571.6 88848.0 90843.0 91627.0 44945.3 56686.0 67278.0 71114.0 72529.3 65677.0 68587.7 69553.3 69928.7 70570.3 9906.9 9964.8 10435.8 10611.5 10624.2 45587.3 46000.5 46603.3 46996.1 47253.5 56396.4 57443.0 61592.7 61739.4 62529.7 13060.0 13081.2 13114.0 13231.6 13350.5 14363.5 14564.9 14760.1 14812.3 14848.5 13380.6 13703.9 13742.7 13872.6 14014.0 13386.6 13871.6 13916.7 13986.2 14327.6 13135.0 13225.0 13315.4 13387.1 13726.4 10814.6 10884.8 11150.2 11266.3 11302.4 11688.0 11718.8 11761.1 11869.3 12076.5 23:51:20 INFO - PROCESS | 22637 | -------- Summary: end -------- 23:51:20 INFO - PROCESS | 22637 | 23:51:20 INFO - TEST-INFO | 22637: exit 0 23:51:21 INFO - TEST-OK | dromaeo_css | took 1112127ms 23:51:21 INFO - TEST-START | kraken 23:51:21 INFO - operating with platform_type : linux_ 23:51:21 INFO - Initialising browser for kraken test... 23:51:21 INFO - TEST-INFO | started process 22984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqh2L3q/profile http://localhost:32846/getInfo.html) 23:51:25 INFO - PROCESS | 22984 | __metrics Screen width/height:1600/1200 23:51:25 INFO - PROCESS | 22984 | colorDepth:24 23:51:25 INFO - PROCESS | 22984 | Browser inner width/height: 1024/697 23:51:25 INFO - PROCESS | 22984 | __metrics 23:51:25 ERROR - PROCESS | 22984 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 23:51:26 INFO - TEST-INFO | 22984: exit 0 23:51:26 INFO - Browser initialized. 23:51:26 INFO - Running cycle 1/1 for kraken test... 23:51:26 INFO - TEST-INFO | started process 23116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqh2L3q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:51:38 INFO - PROCESS | 23116 | RSS: Main: 149291008 23:51:38 INFO - PROCESS | 23116 | 23:51:40 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32846/tests/kraken/driver.html?testName=audio-beat-detection) 23:51:41 INFO - PROCESS | 23116 | RSS: Main: 154304512 23:51:41 INFO - PROCESS | 23116 | 23:51:44 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32846/tests/kraken/driver.html?testName=audio-dft) 23:51:44 INFO - PROCESS | 23116 | RSS: Main: 153051136 23:51:44 INFO - PROCESS | 23116 | 23:51:47 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32846/tests/kraken/driver.html?testName=audio-fft) 23:51:48 INFO - PROCESS | 23116 | RSS: Main: 153518080 23:51:48 INFO - PROCESS | 23116 | 23:51:50 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32846/tests/kraken/driver.html?testName=audio-oscillator) 23:51:50 INFO - PROCESS | 23116 | RSS: Main: 153616384 23:51:50 INFO - PROCESS | 23116 | 23:51:53 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32846/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:51:53 INFO - PROCESS | 23116 | RSS: Main: 153251840 23:51:53 INFO - PROCESS | 23116 | 23:51:56 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32846/tests/kraken/driver.html?testName=imaging-darkroom) 23:51:57 INFO - PROCESS | 23116 | RSS: Main: 156274688 23:51:57 INFO - PROCESS | 23116 | 23:52:00 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32846/tests/kraken/driver.html?testName=imaging-desaturate) 23:52:01 INFO - PROCESS | 23116 | RSS: Main: 156372992 23:52:01 INFO - PROCESS | 23116 | 23:52:03 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32846/tests/kraken/driver.html?testName=json-parse-financial) 23:52:04 INFO - PROCESS | 23116 | RSS: Main: 155787264 23:52:04 INFO - PROCESS | 23116 | 23:52:06 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32846/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:52:06 INFO - PROCESS | 23116 | RSS: Main: 155361280 23:52:06 INFO - PROCESS | 23116 | 23:52:08 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32846/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:52:09 INFO - PROCESS | 23116 | RSS: Main: 155246592 23:52:09 INFO - PROCESS | 23116 | 23:52:11 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32846/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:52:11 INFO - PROCESS | 23116 | RSS: Main: 155742208 23:52:11 INFO - PROCESS | 23116 | 23:52:14 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:52:14 INFO - PROCESS | 23116 | RSS: Main: 156401664 23:52:14 INFO - PROCESS | 23116 | 23:52:17 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:52:18 INFO - PROCESS | 23116 | RSS: Main: 156008448 23:52:18 INFO - PROCESS | 23116 | 23:52:19 INFO - PROCESS | 23116 | Cycle 1(1): loaded http://localhost:32846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32846/tests/kraken/driver.html?testName=ai-astar) 23:52:20 INFO - PROCESS | 23116 | RSS: Main: 157286400 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | __start_tp_report 23:52:20 INFO - PROCESS | 23116 | _x_x_mozilla_page_load 23:52:20 INFO - PROCESS | 23116 | _x_x_mozilla_page_load_details 23:52:20 INFO - PROCESS | 23116 | |i|pagename|runs| 23:52:20 INFO - PROCESS | 23116 | |0;ai-astar;103;110;113;112;111;111;110;110;111;111 23:52:20 INFO - PROCESS | 23116 | |1;audio-beat-detection;146;118;123;153;120;117;118;117;143;126 23:52:20 INFO - PROCESS | 23116 | |2;audio-dft;165;161;163;161;161;163;161;161;163;165 23:52:20 INFO - PROCESS | 23116 | |3;audio-fft;75;76;75;106;76;75;74;75;97;74 23:52:20 INFO - PROCESS | 23116 | |4;audio-oscillator;82;81;100;82;82;82;99;81;82;112 23:52:20 INFO - PROCESS | 23116 | |5;imaging-gaussian-blur;117;117;117;119;117;118;118;118;117;121 23:52:20 INFO - PROCESS | 23116 | |6;imaging-darkroom;148;148;147;147;147;147;148;148;147;147 23:52:20 INFO - PROCESS | 23116 | |7;imaging-desaturate;86;87;84;86;85;85;84;86;85;84 23:52:20 INFO - PROCESS | 23116 | |8;json-parse-financial;53;51;49;52;51;49;50;51;52;55 23:52:20 INFO - PROCESS | 23116 | |9;json-stringify-tinderbox;60;58;58;59;58;62;60;60;58;58 23:52:20 INFO - PROCESS | 23116 | |10;stanford-crypto-aes;76;79;76;76;76;77;76;76;75;76 23:52:20 INFO - PROCESS | 23116 | |11;stanford-crypto-ccm;126;130;140;124;128;124;122;120;170;126 23:52:20 INFO - PROCESS | 23116 | |12;stanford-crypto-pbkdf2;159;158;162;154;163;153;164;154;159;153 23:52:20 INFO - PROCESS | 23116 | |13;stanford-crypto-sha256-iterative;63;61;64;65;63;61;60;64;62;61 23:52:20 INFO - PROCESS | 23116 | __end_tp_report 23:52:20 INFO - PROCESS | 23116 | __start_cc_report 23:52:20 INFO - PROCESS | 23116 | _x_x_mozilla_cycle_collect,765 23:52:20 INFO - PROCESS | 23116 | __end_cc_report 23:52:20 INFO - PROCESS | 23116 | __startTimestamp1485244340158__endTimestamp 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | ------- Summary: start ------- 23:52:20 INFO - PROCESS | 23116 | Number of tests: 14 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.70 (2.4%) stddev-sans-first:1.00 23:52:20 INFO - PROCESS | 23116 | Values: 103.0 110.0 113.0 112.0 111.0 111.0 110.0 110.0 111.0 111.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:124.50 stddev:13.78 (11.1%) stddev-sans-first:13.00 23:52:20 INFO - PROCESS | 23116 | Values: 146.0 118.0 123.0 153.0 120.0 117.0 118.0 117.0 143.0 126.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.65 (1.0%) stddev-sans-first:1.45 23:52:20 INFO - PROCESS | 23116 | Values: 165.0 161.0 163.0 161.0 161.0 163.0 161.0 161.0 163.0 165.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:11.39 (15.2%) stddev-sans-first:11.92 23:52:20 INFO - PROCESS | 23116 | Values: 75.0 76.0 75.0 106.0 76.0 75.0 74.0 75.0 97.0 74.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:82.00 stddev:11.15 (13.6%) stddev-sans-first:11.59 23:52:20 INFO - PROCESS | 23116 | Values: 82.0 81.0 100.0 82.0 82.0 82.0 99.0 81.0 82.0 112.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.29 (1.1%) stddev-sans-first:1.32 23:52:20 INFO - PROCESS | 23116 | Values: 117.0 117.0 117.0 119.0 117.0 118.0 118.0 118.0 117.0 121.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:52:20 INFO - PROCESS | 23116 | Values: 148.0 148.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.03 (1.2%) stddev-sans-first:1.05 23:52:20 INFO - PROCESS | 23116 | Values: 86.0 87.0 84.0 86.0 85.0 85.0 84.0 86.0 85.0 84.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.50 stddev:1.83 (3.6%) stddev-sans-first:1.83 23:52:20 INFO - PROCESS | 23116 | Values: 53.0 51.0 49.0 52.0 51.0 49.0 50.0 51.0 52.0 55.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.50 stddev:1.37 (2.3%) stddev-sans-first:1.41 23:52:20 INFO - PROCESS | 23116 | Values: 60.0 58.0 58.0 59.0 58.0 62.0 60.0 60.0 58.0 58.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:1.06 (1.4%) stddev-sans-first:1.12 23:52:20 INFO - PROCESS | 23116 | Values: 76.0 79.0 76.0 76.0 76.0 77.0 76.0 76.0 75.0 76.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:127.00 stddev:14.76 (11.6%) stddev-sans-first:15.55 23:52:20 INFO - PROCESS | 23116 | Values: 126.0 130.0 140.0 124.0 128.0 124.0 122.0 120.0 170.0 126.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:159.00 stddev:4.23 (2.7%) stddev-sans-first:4.47 23:52:20 INFO - PROCESS | 23116 | Values: 159.0 158.0 162.0 154.0 163.0 153.0 164.0 154.0 159.0 153.0 23:52:20 INFO - PROCESS | 23116 | 23:52:20 INFO - PROCESS | 23116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:1.65 (2.6%) stddev-sans-first:1.73 23:52:20 INFO - PROCESS | 23116 | Values: 63.0 61.0 64.0 65.0 63.0 61.0 60.0 64.0 62.0 61.0 23:52:20 INFO - PROCESS | 23116 | -------- Summary: end -------- 23:52:20 INFO - PROCESS | 23116 | 23:52:21 INFO - TEST-INFO | 23116: exit 0 23:52:21 INFO - TEST-OK | kraken | took 60119ms 23:52:21 INFO - SUITE-END | took 1172s 23:52:21 INFO - Completed test suite (00:19:32) 23:52:21 INFO - javascript benchmark 23:52:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7444.920226874859, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.934921301574, 3278.9508157377645, 3285.6385797562266, 3302.867885284588, 3312.2547426828983, 5679.574031947605, 5723.627964182325, 5738.0, 5748.511376532989, 5752.597318187723, 5667.234923285355, 5681.7727290908415, 5747.42525747425, 5749.540036797046, 5758.0, 5165.974170129163, 5205.531502164805, 5222.216667499867, 5250.081235783722, 5271.472852714736, 5261.368635763694, 5264.92102618461, 5277.12927366984, 5282.128448805943, 5288.973555132238, 5106.897862042757, 5127.538521533062, 5255.921161182585, 5258.1849813279005, 5292.047431462335, 5080.1617733074, 5108.897822043576, 5140.331756871583, 5217.373915130209, 5230.947690523103, 5054.620903432257, 5139.434662187156, 5146.0479811235045, 5151.150060240056, 5154.278401023822, 5567.248421463131, 5585.944140558624, 5657.547396208334, 5678.14827775837, 5706.629069110494, 5947.613405128696, 5950.672713000783, 5979.790707325223, 6000.609960352563, 6018.729157187893, 6001.819945401601, 6040.395960403968, 6048.485878700316, 6050.27396712393, 6055.788047418363, 5676.517496012802, 5681.602287839812, 5682.971585142089, 5691.459311365414, 5702.258706368146, 6062.0, 6094.360092190344, 6129.693515324216, 6131.434797534288, 6171.197744293213, 5865.853353666107, 5913.7876735269165, 5923.0, 5940.821775346746, 5948.970255148696, 6055.091736239511, 6066.605670631395, 6068.817935461943, 6069.302030266487, 6089.8477538061015, 5892.292924849045, 5929.169916211734, 5945.316288626863, 5961.4038596140035, 5969.970150149308, 5953.107033944856, 5998.310194327708, 6006.069059295816, 6029.758809647565, 6039.335673075958, 4622.67641265115, 4624.098300831373, 4655.44134703831, 4655.557722016403, 4698.271767875985, 4023.879283621496, 4067.28822456069, 4091.6112969267874, 4102.815373308208, 4146.543880173179, 5655.971720141455, 5686.2039314496005, 5703.116017017369, 5713.200151978726, 5734.16854556087, 5981.700914954235, 6037.728302226323, 6041.184440100618, 6047.8488037798525, 6058.787942421994, 5600.663960162403, 5633.0, 5694.402087780806, 5696.23100881384, 5697.572682048863, 5130.717810520383, 5143.048536020773, 5169.534741873174, 5174.0169367820745, 5176.378834539879, 6252.155958945576, 6319.494440444753, 6320.968395158086, 6322.9051564226575, 6338.968305158444, 5969.313528944227, 6046.697665116814, 6095.695215239309, 6097.756089756537, 6120.3267640558615, 6248.937510624835, 6377.202849643794, 6382.36176382358, 6386.584871983307, 6393.1369265148605, 6007.789727359522, 6016.909746353896, 6017.247844019497, 6028.668423236764, 6040.818775436744, 5922.141289512911, 5991.520678345809, 6075.574709770451, 6140.232470941132, 6162.815115546541, 6003.969980150071, 6016.0, 6025.638461692312, 6103.7558497661375, 6128.142060111499, 6016.578839481194, 6047.606905551125, 6056.818295451144, 6058.5153187745755, 6092.360302168386, 5684.403137670485, 6034.185384972972, 6036.33600303975, 6041.818745437468, 6042.546808989431, 5833.125031245348, 5898.64608123514, 5911.970440147944, 5951.553633477593, 6023.759049638141, 5805.854853628524, 5814.476697097281, 5816.883662326814, 5817.331006934257, 5828.213191219131], "value": 5594.488652846849, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.8476796033033, 624.282075613045, 640.4172203295002, 664.6942406493016, 672.4015626092776, 46623.76688116563, 48024.519754802444, 48142.277865831995, 50510.0, 50983.0, 47425.52574474263, 47781.28328075082, 47908.0, 47917.76041119798, 47965.760171199094, 8876.378653494274, 9019.143181397789, 9027.503487308195, 9027.864582031241, 9029.413088149282, 8926.821463570725, 9004.77488062797, 9019.45883247004, 9030.819383612325, 9035.909640903605, 9044.276457883354, 9093.681721139761, 9135.269178465707, 9135.36052476327, 9142.542872856364, 8952.373333866632, 9015.864762028576, 9019.59411826466, 9031.593578288926, 9037.18665320121, 8902.376833621649, 8980.371374003822, 8983.68557100505, 8998.55007249635, 9007.054259302744, 43610.781946090065, 43826.0, 43912.12175756467, 43929.56070439287, 44070.77964610157, 3438.209211881281, 3950.249452603996, 4217.903345130258, 4304.7632380219075, 4327.437433133704, 33828.0, 33846.0, 34015.31969360624, 34050.829745851115, 34063.829680851435, 3848.9037774055873, 3849.3263678856088, 3858.9807050964564, 3922.666573341241, 3982.6216509431556, 333022.0, 333366.0, 334733.0, 334906.0, 335705.0, 63136.368636313964, 63706.681466592374, 63718.681406592674, 63930.6803465989, 64113.67943160254, 65954.0, 66035.33964660388, 66097.66951165213, 66171.0, 66185.6690716553, 17537.123143842757, 17781.555461113316, 17806.109694515224, 17912.193951272224, 18071.638567228583, 13242.20546767197, 13325.000624953167, 13347.866521334663, 13371.064025518315, 13428.127171734002, 18582.070896455123, 19413.462637182598, 19574.230027672154, 19664.901675491532, 19810.801891980896, 6794.874357795371, 6976.965115174493, 7046.92953070473, 7066.823329416806, 7114.608696521741, 985.3742873275521, 1058.85705429766, 1078.2021304234809, 1102.8199826186064, 1132.394169119517, 32717.836410817792, 32733.18167045843, 32829.67170328314, 32967.1758206042, 33257.501137482956, 1161.8663853656938, 1167.3229526874393, 1169.1990986174499, 1177.0289511153333, 1225.7425940552405, 17350.91324543369, 17419.47741567755, 17498.475045748648, 17530.211140498708, 17634.470965871045, 480703.0, 480941.0, 481060.0, 481454.0, 486041.0, 61171.694141529006, 61484.692576537724, 61668.69165654143, 61808.38191618026, 61811.690941545006, 1436.289036926707, 1436.5115860607443, 1441.7909403136696, 1453.4549543921241, 1468.3979568377129, 30337.544936825525, 31845.5223171648, 32033.199170020936, 32306.19234519062, 33276.16809579683, 54742.45257547533, 54986.0, 55385.1692224625, 55402.72298638481, 55507.722461387435, 339358.0, 341420.0, 341555.0, 341650.0, 342433.0, 44181.77909110434, 44818.77590612026, 44863.10273794571, 45338.0, 45425.545744542134, 50757.238641419666, 51317.0, 51571.484285156665, 51870.22194667008, 52244.0, 42683.786581066895, 43155.0, 44137.77931110324, 44806.55193448024, 45295.320570190815, 41708.79145604374, 42098.57901420946, 42775.57224427716, 44007.0, 44167.33748993832, 42628.360574590784, 42912.78543607262, 42963.570364295956, 43203.0, 44263.0, 37671.81164094162, 38752.0, 38955.0, 39425.60574394219, 39493.80253098716, 28974.0, 29321.56017659694, 29782.25544361408, 29830.25424364408, 30123.246918827204], "value": 20988.45573728606, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.83114922881606, 415.2960731560007, 425.4214268594711, 432.61281153367736, 446.54898552462004, 18942.24231030759, 20177.596448071028, 20451.897740511296, 20938.0, 21092.894535527303, 19694.606107877833, 19855.0, 20051.699224511645, 20489.692654610193, 20502.589948201028, 5717.59976801623, 6007.519398448114, 6010.429009244137, 6011.098335249704, 6012.068129439922, 5781.248437703114, 5903.970480147594, 5996.220491336142, 6060.848478788022, 6092.847678808043, 6153.35389784073, 6170.136180934673, 6171.413715697024, 6177.25872895251, 6178.10417489466, 6056.364081771417, 6564.376384243489, 6612.14042174519, 6616.239132499776, 6634.3365663433515, 5830.62100963436, 5903.409659034062, 5941.168236446858, 5945.078512830518, 6053.939460605382, 14948.47680331194, 15184.46854360092, 15244.618884527865, 15268.923655381652, 23752.04991800326, 2363.3028256664325, 2366.183666635008, 2417.867017314047, 2498.5877330240487, 2512.773850353477, 10829.729256768565, 11050.33697978124, 11157.218994670377, 13497.055206135574, 14390.568282951528, 1989.9403017909485, 2002.6495363311508, 2012.597480503905, 2042.4791678122133, 2082.8125468707735, 83121.58439207765, 84252.57873710593, 85693.57153214194, 85761.0, 86499.56750216271, 11690.181687281978, 11745.765084698258, 11758.588969323735, 11956.282623042645, 12023.398830058462, 16886.493405197863, 16891.577710557336, 16940.40708575194, 16974.32102715902, 17015.319387224372, 8318.37612179089, 8503.319734421231, 8519.872201916976, 8572.52851093196, 8627.0, 7896.32881205104, 8138.674453021813, 8145.959270203611, 8203.58982050907, 8233.053198882206, 5041.269015992661, 5057.039162559102, 5061.240813877947, 5101.183810590288, 5123.2827404163445, 2095.968560471594, 2097.7902209779204, 2105.0, 2136.8717876927435, 2154.784521547833, 970.5486948568808, 1066.248294952057, 1073.8067147913293, 1102.3165637304921, 1139.1399493382444, 19325.51686207856, 19722.408327750192, 21379.572408551743, 21530.24644137479, 21838.23566175208, 1031.7626945802358, 1050.873895132589, 1051.8737751469873, 1058.751193469534, 1072.7961687279392, 10858.0, 11200.775984480264, 11259.831102533468, 11262.267952583219, 11262.774744505065, 439721.0, 445521.0, 448597.0, 448705.0, 478273.0, 87557.56221218852, 93711.53144234371, 95935.0, 97266.51366743121, 97906.0, 1055.2454994678687, 1064.3135177810425, 1064.3932958213898, 1090.2204923479592, 1110.6723516562633, 17466.73799893028, 17586.120693964996, 17869.821301786815, 17891.910540447214, 18258.0, 42364.576354236066, 42663.20493296978, 43181.784091079346, 43609.781951090044, 44251.0, 54966.450335497735, 57865.710671448054, 58833.70583147228, 59601.40398595959, 64775.02837457536, 8873.822523549621, 8928.73213803587, 9144.451332920045, 9180.173784359173, 9295.76760580991, 9910.702678919644, 12933.159344642569, 13327.067105302536, 13445.193288402726, 13702.65743356424, 11778.882211177779, 11925.0, 12001.279923204636, 12170.269783812999, 12193.146479746332, 10637.0, 10936.179786515884, 11101.944490277498, 11570.537178512765, 11741.0, 11455.427228638368, 11472.196946213686, 11709.238899471507, 11719.589814356457, 11729.530818767495, 8322.568095326082, 8389.706360277361, 8510.91489085126, 8567.914320856711, 8874.866876996979, 10779.51492182838, 11294.0, 11469.827952580552, 11709.297442153498, 11823.586174483851], "value": 9538.562808517008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.2830327291263, 1513.2509407843115, 1692.4076573199382, 1796.5418818201356, 1853.82388673076, 8147.91852081479, 8717.694880679177, 8765.211130998217, 8865.645374185026, 9197.0, 8792.560371981408, 8826.955865220682, 8948.105189481064, 8960.731178064652, 8973.0, 2494.825362224645, 2497.288272842245, 2516.2954372775653, 2525.053105085593, 2528.254165021323, 2340.3447034830274, 2375.714914210297, 2400.8319417640773, 2402.4714562796157, 2407.061246114008, 2420.987895060531, 2426.259990702835, 2451.2646206138174, 2459.29909975657, 2468.049800826677, 2376.275236053003, 2393.8922748476275, 2407.253751337091, 2416.0, 2425.987870060656, 2302.34383200787, 2303.8963246653775, 2308.7344955330186, 2310.861348319106, 2320.153144102407, 8688.08775078614, 8840.646374145026, 8876.689315873979, 8907.153820387053, 8914.955425222897, 5347.385050719178, 5409.540189083933, 5424.484673955968, 5432.70120143392, 5456.208849716809, 3418.66671997921, 3470.392681280791, 3551.6448355164275, 3559.341521818472, 3582.695470884978, 1044.4099084017582, 1052.6263176572284, 1060.173065009294, 1076.39183861119, 1093.0272057868503, 12223.14437989341, 12267.141300108997, 12315.384230788515, 12337.69155771104, 12379.381030948507, 4423.447069116361, 4601.861944141681, 4669.883252918704, 4690.882727931761, 4692.319613656001, 9839.704808855746, 9878.456684882256, 9878.901210987799, 9879.160271377013, 9885.703428897144, 5387.892242155213, 5387.9461205388225, 5392.703401312887, 5420.24116623673, 5426.430224826337, 4850.102730994778, 4978.975105124524, 5100.566451851634, 5177.844664660066, 5204.661696989683, 3668.211334563082, 3736.252749450121, 3762.6049264827348, 3803.0112170835782, 3821.407681809324, 1141.19545720267, 1146.5643055638805, 1151.407025381929, 1160.1125139268465, 1166.0205427440821, 972.1105188752213, 972.1445128287204, 972.9367591106698, 983.7442265011149, 1000.364768372089, 5823.56323275756, 5909.970450147808, 5951.642901425842, 6031.366706495843, 6035.275766907999, 446.894979679775, 452.0890405832251, 454.7476150736373, 457.42364620577644, 460.4037771086451, 4156.106437116035, 4251.829926802893, 4267.786610669454, 4275.080857615628, 4312.0, 10240.846387304196, 10477.37135771856, 10535.0, 10617.362958222377, 10617.416042117604, 10415.375077495375, 10515.631952881766, 10528.684139475828, 10865.619703310345, 10871.83692244617, 8372.58137093143, 8547.316214702809, 8556.144385561518, 8574.928133983252, 8575.95712021436, 5942.346341902474, 5967.134765459071, 6016.0, 6025.18659980897, 6293.496520278275, 10179.440130792878, 10209.74475638115, 10265.230107742098, 10395.064444200058, 10415.166786656897, 10245.129164020844, 10249.48752562354, 10629.787404251718, 10645.201609879136, 10682.89317106819, 7674.61626918663, 7782.805429864298, 7898.091719452336, 7910.52536847791, 7931.405144614292, 8727.607257673548, 8736.99524554659, 8791.692290770048, 8795.868061979203, 8806.339524535557, 7743.264389882952, 7773.067231932205, 7843.764687059397, 7866.960665196638, 7872.409569282212, 7317.8902316466365, 7380.557166570023, 7422.517536360119, 7809.33620642229, 7817.296443320129, 6910.170779506491, 6933.7226510939, 6954.061201737701, 6955.1653801544135, 7145.606991615511, 5083.72039537829, 5223.686578805284, 5276.894462110813, 5287.920681189862, 5311.203319502106, 5153.4073581538605, 5165.147750621106, 5178.533931946143, 5195.090859099567, 5242.5281724644965], "value": 4592.283990239425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.79272643687347, 358.6933172137822, 359.50747475957934, 363.7053986271119, 367.67277123360213, 5578.525825304854, 5628.77484900604, 5680.801171958982, 5693.601447898649, 5708.457696518834, 5576.20817843866, 5609.467100625444, 5618.325800903887, 5621.8594535136535, 5659.462351076651, 4421.624161946223, 4422.270325396305, 4425.941936999295, 4428.778561071934, 4448.177087238855, 4264.55222201669, 4412.77155036706, 4416.246190737863, 4421.469423669164, 4436.312371582394, 4376.1247750449875, 4376.6869939018325, 4384.903774056486, 4385.368778732751, 4390.517043125254, 4381.9342709859375, 4385.802638881258, 4393.846215382462, 4397.120575884804, 4399.5160532341415, 3731.9440208396895, 3880.9521429213955, 3894.1627550076587, 3903.2193561287854, 3908.218356328717, 5399.433059528732, 5432.185172224198, 5437.32033495813, 5440.537554307889, 5461.15352120422, 4994.7013776418025, 4998.250262460624, 5003.4746351633285, 5007.399112106534, 5020.974895125501, 5623.718814059281, 5799.681017544033, 5802.970985145047, 5834.912476312858, 5855.619384739978, 4259.936100958488, 4263.722858014219, 4265.637420819234, 4267.978660106711, 4271.722338048017, 6003.609765365237, 6065.211522502091, 6069.969650151721, 6096.0, 6096.969515152396, 4229.323308270662, 4286.442762440863, 4312.159128969884, 4347.065380943112, 4357.43353364067, 4401.657494464155, 4404.493483249404, 4404.515503294635, 4404.55954404557, 4408.515063343029, 5009.949900500948, 5013.298138260647, 5017.294119999145, 5019.648624596243, 5033.723145226974, 5781.5952883298605, 5885.558583106199, 5903.645781253139, 5908.645481271137, 5929.258842644669, 1490.4336352186099, 1504.9916555907569, 1508.6077619818707, 1516.7638374724784, 1518.1933499135994, 1023.9283250172565, 1061.0715623829149, 1072.8766191887876, 1075.5267682219956, 1080.206048554312, 5385.9730701347025, 5447.373552041487, 5460.672359658433, 5462.726863656881, 5502.367227768777, 5847.912281315784, 5863.3257175424515, 5864.0, 5880.500157486662, 5887.587868849225, 5309.0, 5385.0, 5395.649282796684, 5472.753726082336, 5476.808311709071, 3077.2153100959113, 3116.3299890523645, 3134.1067795678123, 3138.952915706266, 3145.716885480272, 5975.207437768652, 6064.4541991221, 6075.301340345828, 6078.787242446493, 6100.620757904421, 6151.9384806151365, 6204.5967012144065, 6206.906896396557, 6217.751289948442, 6223.719932603044, 6216.968915155395, 6343.302236753953, 6352.904706429407, 6358.936410635927, 6375.808725738235, 5961.4038596140035, 6071.482129467633, 6077.450250186174, 6087.66517841523, 6127.0, 5979.727703472652, 6015.157877897011, 6025.758969641165, 6032.54755893301, 6055.091736239599, 6140.263168419639, 6294.402031806971, 6340.9048864268, 6349.523785715997, 6352.0, 4193.937090943699, 4232.365145228117, 4235.703500755041, 4245.936310955276, 4254.234237837219, 5911.645301281765, 6086.878262434815, 6117.785877494266, 6117.941029485258, 6121.449069583581, 5898.233229680114, 5931.169636251015, 5972.297175751062, 5974.253218347707, 5981.0, 5906.320773111147, 5906.468417842415, 5916.171735957056, 5919.911201331897, 5938.257717785277, 5716.857078573069, 5873.530117590668, 5881.617694849821, 5919.0, 5930.466258036798, 5948.0, 5961.0, 5967.181004157256, 5967.761289548543, 5975.611585246945, 5683.403242659461, 5779.682117483579, 5792.884142317214, 5796.59423840344, 5820.417958204146], "value": 4498.993529805948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.7046566606191, 774.639792496489, 789.403999980015, 817.9672813087477, 861.7457849934269, 14206.502772402968, 14508.274586270698, 14541.709165816677, 14566.854331456681, 14596.635084122901, 14307.57077287683, 15256.466023689145, 15772.211389430511, 15836.683266334667, 16269.186540672978, 679.6329981809816, 699.8600279944006, 703.5040296590892, 840.1346612988616, 848.4315508609246, 828.1842385250553, 828.4615000249855, 831.6382373667444, 839.1147339556766, 840.504102579478, 887.5029983209423, 888.8622263549161, 889.0798024045115, 889.4352086425134, 889.4974339498195, 874.8993865705462, 881.5504092912629, 882.5675419044686, 883.6509578716403, 886.6940905387631, 655.115593948171, 655.9147310849606, 657.2540166910543, 657.9572327798726, 659.7789740436959, 15394.692106157927, 15506.9224653876, 15537.533873983799, 15547.92226038874, 16094.436694715629, 14394.352254148589, 14713.779293310608, 15114.168720720356, 15178.924105379512, 15308.770368444371, 11900.940495297467, 12018.218815776947, 12026.699332516757, 12057.93971030148, 12185.086118541145, 3900.7659540427667, 3933.115049113955, 3944.467496887912, 3966.880993570169, 4005.419214213952, 67640.6617966907, 69444.6527767363, 70044.6497767513, 70943.64528177377, 71443.28556714418, 10555.0, 10669.413182274895, 10687.412192329497, 10714.678559643224, 11074.889251107546, 20668.793312066686, 20770.273040443513, 20854.687179692315, 20941.371758847257, 21163.365099047052, 8142.3486121111355, 8206.630701618442, 8323.167683231628, 8333.0, 8458.703945362005, 4327.112941846914, 4443.37792709021, 4495.325701144789, 4535.274356103074, 4599.724016559017, 3468.601110872282, 3594.8202589870402, 3596.28074385124, 3604.4773507841214, 3608.747387682837, 592.8340064781868, 662.3376623376623, 688.5386790850142, 690.147667630476, 695.7738734911175, 612.0, 700.1598082301157, 748.2442732839871, 788.787027502571, 796.2037962037962, 9339.533023348806, 9933.950330248303, 10049.346792458467, 10092.0, 10159.390436573829, 688.9621070841051, 741.6069483173926, 765.9923400765921, 776.4332037612462, 776.9300762931364, 4807.399075115611, 4809.0, 4879.26810978349, 4891.828785992473, 5026.095302845523, 72191.2780872195, 75571.62214188893, 88848.0, 90843.0, 91627.0, 44945.325820112725, 56686.0, 67278.0, 71114.0, 72529.27470725331, 65677.0, 68587.65706171437, 69553.3044669557, 69928.6503567479, 70570.2942970574, 9906.851397229191, 9964.750881228027, 10435.843462347919, 10611.469426528796, 10624.20318476102, 45587.31619025651, 46000.539994599625, 46603.30095048509, 46996.06007879755, 47253.52746472491, 56396.43603563912, 57443.0, 61592.69203653953, 61739.38260617336, 62529.68735156295, 13060.0, 13081.215127092404, 13114.0, 13231.603051908458, 13350.465981360638, 14363.450460111142, 14564.927175364055, 14760.114393136446, 14812.333444995216, 14848.480303189337, 13380.598582042554, 13703.862961370258, 13742.65643358924, 13872.583822485341, 14014.0, 13386.598402047954, 13871.583852484442, 13916.721665566429, 13986.16083035021, 14327.641808954859, 13135.0, 13225.0, 13315.400806963517, 13387.129836560593, 13726.382312796148, 10814.621488248189, 10884.782304354027, 11150.163737719866, 11266.324020558794, 11302.378369189773, 11688.0, 11718.765624687629, 11761.117916156152, 11869.347185904859, 12076.51693932233], "value": 7357.807102152975, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 113.0, 112.0, 111.0, 111.0, 110.0, 110.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 123.0, 153.0, 120.0, 117.0, 118.0, 117.0, 143.0, 126.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 163.0, 161.0, 161.0, 163.0, 161.0, 161.0, 163.0, 165.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 106.0, 76.0, 75.0, 74.0, 75.0, 97.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 100.0, 82.0, 82.0, 82.0, 99.0, 81.0, 82.0, 112.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 118.0, 118.0, 117.0, 121.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 86.0, 85.0, 85.0, 84.0, 86.0, 85.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 49.0, 52.0, 51.0, 49.0, 50.0, 51.0, 52.0, 55.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 59.0, 58.0, 62.0, 60.0, 60.0, 58.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 76.0, 76.0, 77.0, 76.0, 76.0, 75.0, 76.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 130.0, 140.0, 124.0, 128.0, 124.0, 122.0, 120.0, 170.0, 126.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 162.0, 154.0, 163.0, 153.0, 164.0, 154.0, 159.0, 153.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 64.0, 65.0, 63.0, 61.0, 60.0, 64.0, 62.0, 61.0], "value": 62.4, "unit": "score"}]}]} 23:52:21 INFO - Return code: 0 23:52:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:52:21 ERROR - # TBPL SUCCESS # 23:52:21 INFO - Running post-action listener: _resource_record_post_action 23:52:21 INFO - [mozharness: 2017-01-24 07:52:21.460803Z] Finished run-tests step (success) 23:52:21 INFO - Running post-run listener: _resource_record_post_run 23:52:21 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 321368064; Read time: 44; Write time: 138448 23:52:21 INFO - TinderboxPrint: CPU usage
13.2% 23:52:21 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 44 23:52:21 INFO - TinderboxPrint: I/O write bytes / time
321,368,064 / 138,448 23:52:21 INFO - TinderboxPrint: CPU idle
8,221.9 (86.8%) 23:52:21 INFO - TinderboxPrint: CPU user
1,196.5 (12.6%) 23:52:21 INFO - TinderboxPrint: Swap in / out
0 / 0 23:52:21 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100646912; Read time: 0; Write time: 46188 23:52:21 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 219353088; Read time: 32; Write time: 92204 23:52:22 INFO - Running post-run listener: _upload_blobber_files 23:52:22 INFO - Blob upload gear active. 23:52:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:52:22 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 23:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:52:22 INFO - (blobuploader) - INFO - Open directory for files ... 23:52:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:52:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:52:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:52:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:52:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:52:23 INFO - (blobuploader) - INFO - Done attempting. 23:52:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:52:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:52:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:52:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:52:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:52:24 INFO - (blobuploader) - INFO - Done attempting. 23:52:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:52:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:52:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:52:27 INFO - (blobuploader) - INFO - Done attempting. 23:52:27 INFO - (blobuploader) - INFO - Iteration through files over. 23:52:27 INFO - Return code: 0 23:52:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:52:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:52:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5de93da121c06929d606d83e8f38f237ffd44969f30f34cf45be8dc22b47fa345f4bb3942b4b0daa9801b20615083c03385ea4b78f3c3eb409d4bfaf20368093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/78c544b3cfc7ddf3ee6af86a6647227a2096c5f22ff9a8fe411110aa9d50bf49eba553f436340c5556808042bc61682ddeb4dc8ce2e0028d0622bd23ef60d16b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c58038c897b09c2905181bfa409ab46cfd0fb4fba41ceaf355f3247672caee35aea12ec51f868a8dd1c2151da069c75b1a44eccfd6923c22fa88dc5b3d26f5c"} 23:52:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:52:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:52:27 INFO - Contents: 23:52:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5de93da121c06929d606d83e8f38f237ffd44969f30f34cf45be8dc22b47fa345f4bb3942b4b0daa9801b20615083c03385ea4b78f3c3eb409d4bfaf20368093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/78c544b3cfc7ddf3ee6af86a6647227a2096c5f22ff9a8fe411110aa9d50bf49eba553f436340c5556808042bc61682ddeb4dc8ce2e0028d0622bd23ef60d16b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c58038c897b09c2905181bfa409ab46cfd0fb4fba41ceaf355f3247672caee35aea12ec51f868a8dd1c2151da069c75b1a44eccfd6923c22fa88dc5b3d26f5c"} 23:52:27 INFO - Running post-run listener: copy_logs_to_upload_dir 23:52:27 INFO - Copying logs to upload dir... 23:52:27 INFO - mkdir: /builds/slave/test/build/upload/logs 23:52:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.941191 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-01-23 23:52:27.626720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 23:52:27.630094) ========= 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=523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5de93da121c06929d606d83e8f38f237ffd44969f30f34cf45be8dc22b47fa345f4bb3942b4b0daa9801b20615083c03385ea4b78f3c3eb409d4bfaf20368093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/78c544b3cfc7ddf3ee6af86a6647227a2096c5f22ff9a8fe411110aa9d50bf49eba553f436340c5556808042bc61682ddeb4dc8ce2e0028d0622bd23ef60d16b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c58038c897b09c2905181bfa409ab46cfd0fb4fba41ceaf355f3247672caee35aea12ec51f868a8dd1c2151da069c75b1a44eccfd6923c22fa88dc5b3d26f5c"} build_url:https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5de93da121c06929d606d83e8f38f237ffd44969f30f34cf45be8dc22b47fa345f4bb3942b4b0daa9801b20615083c03385ea4b78f3c3eb409d4bfaf20368093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/78c544b3cfc7ddf3ee6af86a6647227a2096c5f22ff9a8fe411110aa9d50bf49eba553f436340c5556808042bc61682ddeb4dc8ce2e0028d0622bd23ef60d16b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c58038c897b09c2905181bfa409ab46cfd0fb4fba41ceaf355f3247672caee35aea12ec51f868a8dd1c2151da069c75b1a44eccfd6923c22fa88dc5b3d26f5c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 23:52:27.655705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:52:27.656033) ========= 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=523ca41ca1e0623de333ad52000001bf-1485242211.554221-990556917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:52:27.738514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 23:52:27.738842) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 23:52:27.739126) ========= ========= Total master_lag: 0.17 =========